builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1457312164.24 results: success (0) buildid: 20160306143005 builduid: 374e9f2f86f144209bf36a69e7790236 revision: b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.244005) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.244397) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.244680) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006306 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.270157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.270448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.296748) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.297013) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.350192) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.350503) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.351029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.351318) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-06 16:56:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.7M=0s 2016-03-06 16:56:04 (95.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184161 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.556714) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.556996) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020385 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.611842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:04.612204) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-06 16:56:04,676 truncating revision to first 12 chars 2016-03-06 16:56:04,676 Setting DEBUG logging. 2016-03-06 16:56:04,676 attempt 1/10 2016-03-06 16:56:04,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b6acf4d4fc20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-06 16:56:04,946 unpacking tar archive at: fx-team-b6acf4d4fc20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:05.213666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:05.213964) ========= echo b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad program finished with exit code 0 elapsedTime=0.004521 script_repo_revision: 'b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:05.264437) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:05.264713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-06 16:56:05.274074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-06 16:56:05.274351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:56:05 INFO - MultiFileLogger online at 20160306 16:56:05 in /builds/slave/test-pgo 16:56:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:56:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:56:05 INFO - {'append_to_log': False, 16:56:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:56:05 INFO - 'blob_upload_branch': 'Fx-Team', 16:56:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:56:05 INFO - 'branch': 'Fx-Team', 16:56:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:05 INFO - 'config_files': ('talos/linux_config.py',), 16:56:05 INFO - 'default_actions': ('clobber', 16:56:05 INFO - 'read-buildbot-config', 16:56:05 INFO - 'download-and-extract', 16:56:05 INFO - 'populate-webroot', 16:56:05 INFO - 'create-virtualenv', 16:56:05 INFO - 'install', 16:56:05 INFO - 'run-tests'), 16:56:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:05 INFO - 'download_minidump_stackwalk': True, 16:56:05 INFO - 'download_symbols': 'ondemand', 16:56:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:05 INFO - 'installer_path': 'installer.exe', 16:56:05 INFO - 'log_level': 'info', 16:56:05 INFO - 'log_name': 'talos', 16:56:05 INFO - 'log_to_console': True, 16:56:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:56:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:56:05 INFO - 'opt_config_files': (), 16:56:05 INFO - 'pip_index': False, 16:56:05 INFO - 'sps_profile': False, 16:56:05 INFO - 'sps_profile_interval': 0, 16:56:05 INFO - 'suite': 'dromaeojs-e10s', 16:56:05 INFO - 'system_bits': '32', 16:56:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:05 INFO - 'title': 'talos-linux64-ix-036', 16:56:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:05 INFO - 'use_talos_json': True, 16:56:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:56:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:05 INFO - 'work_dir': 'build'} 16:56:05 INFO - ##### 16:56:05 INFO - ##### Running clobber step. 16:56:05 INFO - ##### 16:56:05 INFO - Running pre-action listener: _resource_record_pre_action 16:56:05 INFO - Running main action method: clobber 16:56:05 INFO - rmtree: /builds/slave/test-pgo/build 16:56:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:56:05 INFO - Running post-action listener: _resource_record_post_action 16:56:05 INFO - ##### 16:56:05 INFO - ##### Running read-buildbot-config step. 16:56:05 INFO - ##### 16:56:05 INFO - Running pre-action listener: _resource_record_pre_action 16:56:05 INFO - Running main action method: read_buildbot_config 16:56:05 INFO - Using buildbot properties: 16:56:05 INFO - { 16:56:05 INFO - "project": "", 16:56:05 INFO - "product": "firefox", 16:56:05 INFO - "script_repo_revision": "production", 16:56:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:56:05 INFO - "repository": "", 16:56:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:56:05 INFO - "buildid": "20160306143005", 16:56:05 INFO - "pgo_build": "True", 16:56:05 INFO - "basedir": "/builds/slave/test-pgo", 16:56:05 INFO - "buildnumber": 219, 16:56:05 INFO - "slavename": "talos-linux64-ix-036", 16:56:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:56:05 INFO - "platform": "ubuntu64_hw", 16:56:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:56:05 INFO - "branch": "fx-team", 16:56:05 INFO - "repo_path": "integration/fx-team", 16:56:05 INFO - "revision": "b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad", 16:56:05 INFO - "stage_platform": "linux64-pgo", 16:56:05 INFO - "builduid": "374e9f2f86f144209bf36a69e7790236", 16:56:05 INFO - "slavebuilddir": "test" 16:56:05 INFO - } 16:56:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:56:05 INFO - Running post-action listener: _resource_record_post_action 16:56:05 INFO - ##### 16:56:05 INFO - ##### Running download-and-extract step. 16:56:05 INFO - ##### 16:56:05 INFO - Running pre-action listener: _resource_record_pre_action 16:56:05 INFO - Running main action method: download_and_extract 16:56:05 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:05 INFO - https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:56:06 INFO - Downloaded 1448 bytes. 16:56:06 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 16:56:06 INFO - Using the following test package requirements: 16:56:06 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:06 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:56:06 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:56:06 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'jsshell-linux-x86_64.zip'], 16:56:06 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:56:06 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:06 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:56:06 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:56:06 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:56:06 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:56:06 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:56:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:56:06 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:06 INFO - https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:08 INFO - Downloaded 23405369 bytes. 16:56:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:56:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:56:09 INFO - Return code: 0 16:56:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:09 INFO - https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:56:12 INFO - Downloaded 23405369 bytes. 16:56:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:56:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:56:14 INFO - Return code: 0 16:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:14 INFO - https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:56:15 INFO - Downloaded 10845161 bytes. 16:56:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:56:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:56:15 INFO - Return code: 0 16:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:15 INFO - https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:56:17 INFO - Downloaded 56180902 bytes. 16:56:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:56:17 INFO - mkdir: /builds/slave/test-pgo/properties 16:56:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:56:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:56:17 INFO - Contents: 16:56:17 INFO - build_url:https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:56:18 INFO - Running post-action listener: _resource_record_post_action 16:56:18 INFO - Running post-action listener: set_extra_try_arguments 16:56:18 INFO - ##### 16:56:18 INFO - ##### Running populate-webroot step. 16:56:18 INFO - ##### 16:56:18 INFO - Running pre-action listener: _resource_record_pre_action 16:56:18 INFO - Running main action method: populate_webroot 16:56:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:56:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:56:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:56:18 INFO - '--tppagecycles', 16:56:18 INFO - '7'], 16:56:18 INFO - 'tests': ['tsvgm']}}, 16:56:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:56:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:56:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:56:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:56:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:56:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['damp', 'tps']}, 16:56:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['damp', 'tps']}, 16:56:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:56:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:56:18 INFO - 'other': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other_l64': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'other_nol64': {'tests': ['a11yr', 16:56:18 INFO - 'ts_paint', 16:56:18 INFO - 'tpaint', 16:56:18 INFO - 'sessionrestore', 16:56:18 INFO - 'sessionrestore_no_auto_restore', 16:56:18 INFO - 'tabpaint']}, 16:56:18 INFO - 'svgr': {'tests': ['tsvgx', 16:56:18 INFO - 'tsvgr_opacity', 16:56:18 INFO - 'tart', 16:56:18 INFO - 'tscrollx', 16:56:18 INFO - 'cart']}, 16:56:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['tsvgx', 16:56:18 INFO - 'tsvgr_opacity', 16:56:18 INFO - 'tart', 16:56:18 INFO - 'tscrollx', 16:56:18 INFO - 'cart']}, 16:56:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'tests': ['tp5o']}, 16:56:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--e10s'], 16:56:18 INFO - 'tests': ['tp5o']}, 16:56:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--xperf_path', 16:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:18 INFO - 'tests': ['tp5n']}, 16:56:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:56:18 INFO - 'talos_options': ['--e10s', 16:56:18 INFO - '--xperf_path', 16:56:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:56:18 INFO - 'tests': ['tp5n']}}, 16:56:18 INFO - 'talos.zip': {'path': '', 16:56:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:56:18 INFO - Running post-action listener: _resource_record_post_action 16:56:18 INFO - ##### 16:56:18 INFO - ##### Running create-virtualenv step. 16:56:18 INFO - ##### 16:56:18 INFO - Running pre-action listener: _resource_record_pre_action 16:56:18 INFO - Running main action method: create_virtualenv 16:56:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:56:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 16:56:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:56:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:56:18 INFO - Using real prefix '/usr' 16:56:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:56:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:56:21 INFO - Installing pip.................done. 16:56:21 INFO - Return code: 0 16:56:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 16:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:56:21 INFO - Using env: {'DISPLAY': ':0', 16:56:21 INFO - 'HOME': '/home/cltbld', 16:56:21 INFO - 'LANG': 'en_US.UTF-8', 16:56:21 INFO - 'LANGUAGE': 'en_US:en', 16:56:21 INFO - 'LOGNAME': 'cltbld', 16:56:21 INFO - 'MAIL': '/var/mail/cltbld', 16:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:21 INFO - 'MOZ_NO_REMOTE': '1', 16:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:21 INFO - 'NO_EM_RESTART': '1', 16:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:21 INFO - 'SHELL': '/bin/bash', 16:56:21 INFO - 'SHLVL': '1', 16:56:21 INFO - 'TERM': 'linux', 16:56:21 INFO - 'TMOUT': '86400', 16:56:21 INFO - 'USER': 'cltbld', 16:56:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:21 INFO - '_': '/tools/buildbot/bin/python'} 16:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:56:21 INFO - Cleaning up... 16:56:21 INFO - Return code: 0 16:56:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 16:56:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:56:21 INFO - Using env: {'DISPLAY': ':0', 16:56:21 INFO - 'HOME': '/home/cltbld', 16:56:21 INFO - 'LANG': 'en_US.UTF-8', 16:56:21 INFO - 'LANGUAGE': 'en_US:en', 16:56:21 INFO - 'LOGNAME': 'cltbld', 16:56:21 INFO - 'MAIL': '/var/mail/cltbld', 16:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:21 INFO - 'MOZ_NO_REMOTE': '1', 16:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:21 INFO - 'NO_EM_RESTART': '1', 16:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:21 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:21 INFO - 'SHELL': '/bin/bash', 16:56:21 INFO - 'SHLVL': '1', 16:56:21 INFO - 'TERM': 'linux', 16:56:21 INFO - 'TMOUT': '86400', 16:56:21 INFO - 'USER': 'cltbld', 16:56:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:21 INFO - '_': '/tools/buildbot/bin/python'} 16:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:21 INFO - Downloading/unpacking psutil>=0.7.1 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:23 INFO - Installing collected packages: psutil 16:56:23 INFO - Running setup.py install for psutil 16:56:23 INFO - building 'psutil._psutil_linux' extension 16:56:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:56:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:56:23 INFO - building 'psutil._psutil_posix' extension 16:56:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:56:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:56:24 INFO - Successfully installed psutil 16:56:24 INFO - Cleaning up... 16:56:24 INFO - Return code: 0 16:56:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 16:56:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:56:24 INFO - Using env: {'DISPLAY': ':0', 16:56:24 INFO - 'HOME': '/home/cltbld', 16:56:24 INFO - 'LANG': 'en_US.UTF-8', 16:56:24 INFO - 'LANGUAGE': 'en_US:en', 16:56:24 INFO - 'LOGNAME': 'cltbld', 16:56:24 INFO - 'MAIL': '/var/mail/cltbld', 16:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:24 INFO - 'MOZ_NO_REMOTE': '1', 16:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:24 INFO - 'NO_EM_RESTART': '1', 16:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:24 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:24 INFO - 'SHELL': '/bin/bash', 16:56:24 INFO - 'SHLVL': '1', 16:56:24 INFO - 'TERM': 'linux', 16:56:24 INFO - 'TMOUT': '86400', 16:56:24 INFO - 'USER': 'cltbld', 16:56:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:24 INFO - '_': '/tools/buildbot/bin/python'} 16:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:56:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:56:26 INFO - Installing collected packages: mozsystemmonitor 16:56:26 INFO - Running setup.py install for mozsystemmonitor 16:56:26 INFO - Successfully installed mozsystemmonitor 16:56:26 INFO - Cleaning up... 16:56:27 INFO - Return code: 0 16:56:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:56:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:56:27 INFO - Using env: {'DISPLAY': ':0', 16:56:27 INFO - 'HOME': '/home/cltbld', 16:56:27 INFO - 'LANG': 'en_US.UTF-8', 16:56:27 INFO - 'LANGUAGE': 'en_US:en', 16:56:27 INFO - 'LOGNAME': 'cltbld', 16:56:27 INFO - 'MAIL': '/var/mail/cltbld', 16:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:27 INFO - 'MOZ_NO_REMOTE': '1', 16:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:27 INFO - 'NO_EM_RESTART': '1', 16:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:27 INFO - 'SHELL': '/bin/bash', 16:56:27 INFO - 'SHLVL': '1', 16:56:27 INFO - 'TERM': 'linux', 16:56:27 INFO - 'TMOUT': '86400', 16:56:27 INFO - 'USER': 'cltbld', 16:56:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:27 INFO - '_': '/tools/buildbot/bin/python'} 16:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:56:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:29 INFO - Downloading docopt-0.6.1.tar.gz 16:56:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:29 INFO - Running setup.py install for blobuploader 16:56:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:56:29 INFO - Running setup.py install for requests 16:56:30 INFO - Running setup.py install for docopt 16:56:30 INFO - Successfully installed blobuploader requests docopt 16:56:30 INFO - Cleaning up... 16:56:30 INFO - Return code: 0 16:56:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:56:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:30 INFO - Using env: {'DISPLAY': ':0', 16:56:30 INFO - 'HOME': '/home/cltbld', 16:56:30 INFO - 'LANG': 'en_US.UTF-8', 16:56:30 INFO - 'LANGUAGE': 'en_US:en', 16:56:30 INFO - 'LOGNAME': 'cltbld', 16:56:30 INFO - 'MAIL': '/var/mail/cltbld', 16:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:30 INFO - 'MOZ_NO_REMOTE': '1', 16:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:30 INFO - 'NO_EM_RESTART': '1', 16:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:30 INFO - 'SHELL': '/bin/bash', 16:56:30 INFO - 'SHLVL': '1', 16:56:30 INFO - 'TERM': 'linux', 16:56:30 INFO - 'TMOUT': '86400', 16:56:30 INFO - 'USER': 'cltbld', 16:56:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:30 INFO - '_': '/tools/buildbot/bin/python'} 16:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:30 INFO - Running setup.py (path:/tmp/pip-jqVRIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:30 INFO - Running setup.py (path:/tmp/pip-LNtPtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:30 INFO - Running setup.py (path:/tmp/pip-XRLLxJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:30 INFO - Running setup.py (path:/tmp/pip-zrQegS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:30 INFO - Running setup.py (path:/tmp/pip-cqZQbu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:30 INFO - Running setup.py (path:/tmp/pip-MLh1wl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:31 INFO - Running setup.py (path:/tmp/pip-yN84H6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:31 INFO - Running setup.py (path:/tmp/pip-YC1ZQ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:31 INFO - Running setup.py (path:/tmp/pip-QJvd6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:31 INFO - Running setup.py (path:/tmp/pip-AVz8QU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:31 INFO - Running setup.py (path:/tmp/pip-WTzPE7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:31 INFO - Running setup.py (path:/tmp/pip-7FakG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:31 INFO - Running setup.py (path:/tmp/pip-cFAvRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:31 INFO - Running setup.py (path:/tmp/pip-cnK1vG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:31 INFO - Running setup.py (path:/tmp/pip-Xks37V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:31 INFO - Running setup.py (path:/tmp/pip-F0qRQV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:31 INFO - Running setup.py (path:/tmp/pip-9FW3jG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:31 INFO - Running setup.py install for manifestparser 16:56:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:56:31 INFO - Running setup.py install for mozcrash 16:56:32 INFO - Running setup.py install for mozdebug 16:56:32 INFO - Running setup.py install for mozdevice 16:56:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for mozfile 16:56:32 INFO - Running setup.py install for mozhttpd 16:56:32 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for mozinfo 16:56:32 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for mozInstall 16:56:32 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for mozleak 16:56:32 INFO - Running setup.py install for mozlog 16:56:32 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for moznetwork 16:56:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:56:32 INFO - Running setup.py install for mozprocess 16:56:33 INFO - Running setup.py install for mozprofile 16:56:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:56:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:56:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:56:33 INFO - Running setup.py install for mozrunner 16:56:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:56:33 INFO - Running setup.py install for mozscreenshot 16:56:33 INFO - Running setup.py install for moztest 16:56:33 INFO - Running setup.py install for mozversion 16:56:33 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:56:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:33 INFO - Cleaning up... 16:56:33 INFO - Return code: 0 16:56:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:56:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:33 INFO - Using env: {'DISPLAY': ':0', 16:56:33 INFO - 'HOME': '/home/cltbld', 16:56:33 INFO - 'LANG': 'en_US.UTF-8', 16:56:33 INFO - 'LANGUAGE': 'en_US:en', 16:56:33 INFO - 'LOGNAME': 'cltbld', 16:56:33 INFO - 'MAIL': '/var/mail/cltbld', 16:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:33 INFO - 'MOZ_NO_REMOTE': '1', 16:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:33 INFO - 'NO_EM_RESTART': '1', 16:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:33 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:33 INFO - 'SHELL': '/bin/bash', 16:56:33 INFO - 'SHLVL': '1', 16:56:33 INFO - 'TERM': 'linux', 16:56:33 INFO - 'TMOUT': '86400', 16:56:33 INFO - 'USER': 'cltbld', 16:56:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:33 INFO - '_': '/tools/buildbot/bin/python'} 16:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:33 INFO - Running setup.py (path:/tmp/pip-XryhzW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 16:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:33 INFO - Running setup.py (path:/tmp/pip-JWUqok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:34 INFO - Running setup.py (path:/tmp/pip-BfCxub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:34 INFO - Running setup.py (path:/tmp/pip-8m5hvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:34 INFO - Running setup.py (path:/tmp/pip-cIckBK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:34 INFO - Running setup.py (path:/tmp/pip-UUktMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:34 INFO - Running setup.py (path:/tmp/pip-XvTCtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:34 INFO - Running setup.py (path:/tmp/pip-zUtHcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:34 INFO - Running setup.py (path:/tmp/pip-cnwKJv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:34 INFO - Running setup.py (path:/tmp/pip-oG5ST1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:34 INFO - Running setup.py (path:/tmp/pip-GKbBtx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:34 INFO - Running setup.py (path:/tmp/pip-_Eov5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:34 INFO - Running setup.py (path:/tmp/pip-Jnr7UC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:34 INFO - Running setup.py (path:/tmp/pip-saYFFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:34 INFO - Running setup.py (path:/tmp/pip-re3rGQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 16:56:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:34 INFO - Running setup.py (path:/tmp/pip-EfhH82-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 16:56:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:35 INFO - Running setup.py (path:/tmp/pip-8BLJ_7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:36 INFO - Downloading blessings-1.6.tar.gz 16:56:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:36 INFO - Installing collected packages: blessings 16:56:36 INFO - Running setup.py install for blessings 16:56:37 INFO - Successfully installed blessings 16:56:37 INFO - Cleaning up... 16:56:37 INFO - Return code: 0 16:56:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:56:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:56:37 INFO - Reading from file tmpfile_stdout 16:56:37 INFO - Current package versions: 16:56:37 INFO - argparse == 1.2.1 16:56:37 INFO - blessings == 1.6 16:56:37 INFO - blobuploader == 1.2.4 16:56:37 INFO - docopt == 0.6.1 16:56:37 INFO - manifestparser == 1.1 16:56:37 INFO - mozInstall == 1.12 16:56:37 INFO - mozcrash == 0.17 16:56:37 INFO - mozdebug == 0.1 16:56:37 INFO - mozdevice == 0.48 16:56:37 INFO - mozfile == 1.2 16:56:37 INFO - mozhttpd == 0.7 16:56:37 INFO - mozinfo == 0.9 16:56:37 INFO - mozleak == 0.1 16:56:37 INFO - mozlog == 3.1 16:56:37 INFO - moznetwork == 0.27 16:56:37 INFO - mozprocess == 0.22 16:56:37 INFO - mozprofile == 0.28 16:56:37 INFO - mozrunner == 6.11 16:56:37 INFO - mozscreenshot == 0.1 16:56:37 INFO - mozsystemmonitor == 0.0 16:56:37 INFO - moztest == 0.7 16:56:37 INFO - mozversion == 1.4 16:56:37 INFO - psutil == 3.1.1 16:56:37 INFO - requests == 1.2.3 16:56:37 INFO - wsgiref == 0.1.2 16:56:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:56:37 INFO - Using env: {'DISPLAY': ':0', 16:56:37 INFO - 'HOME': '/home/cltbld', 16:56:37 INFO - 'LANG': 'en_US.UTF-8', 16:56:37 INFO - 'LANGUAGE': 'en_US:en', 16:56:37 INFO - 'LOGNAME': 'cltbld', 16:56:37 INFO - 'MAIL': '/var/mail/cltbld', 16:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:37 INFO - 'MOZ_NO_REMOTE': '1', 16:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:37 INFO - 'NO_EM_RESTART': '1', 16:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:37 INFO - 'SHELL': '/bin/bash', 16:56:37 INFO - 'SHLVL': '1', 16:56:37 INFO - 'TERM': 'linux', 16:56:37 INFO - 'TMOUT': '86400', 16:56:37 INFO - 'USER': 'cltbld', 16:56:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:37 INFO - '_': '/tools/buildbot/bin/python'} 16:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:56:37 INFO - Cleaning up... 16:56:37 INFO - Return code: 0 16:56:37 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:56:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:56:37 INFO - Using env: {'DISPLAY': ':0', 16:56:37 INFO - 'HOME': '/home/cltbld', 16:56:37 INFO - 'LANG': 'en_US.UTF-8', 16:56:37 INFO - 'LANGUAGE': 'en_US:en', 16:56:37 INFO - 'LOGNAME': 'cltbld', 16:56:37 INFO - 'MAIL': '/var/mail/cltbld', 16:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:37 INFO - 'MOZ_NO_REMOTE': '1', 16:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:37 INFO - 'NO_EM_RESTART': '1', 16:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:37 INFO - 'SHELL': '/bin/bash', 16:56:37 INFO - 'SHLVL': '1', 16:56:37 INFO - 'TERM': 'linux', 16:56:37 INFO - 'TMOUT': '86400', 16:56:37 INFO - 'USER': 'cltbld', 16:56:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:37 INFO - '_': '/tools/buildbot/bin/python'} 16:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:37 INFO - Downloading/unpacking jsonschema 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:39 INFO - Downloading/unpacking functools32 (from jsonschema) 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:39 INFO - warning: no files found matching '*.txt' 16:56:39 INFO - no previously-included directories found matching 'build' 16:56:39 INFO - no previously-included directories found matching 'dist' 16:56:39 INFO - no previously-included directories found matching '.git*' 16:56:39 INFO - Installing collected packages: jsonschema, functools32 16:56:39 INFO - Running setup.py install for functools32 16:56:40 INFO - warning: no files found matching '*.txt' 16:56:40 INFO - no previously-included directories found matching 'build' 16:56:40 INFO - no previously-included directories found matching 'dist' 16:56:40 INFO - no previously-included directories found matching '.git*' 16:56:40 INFO - Successfully installed jsonschema functools32 16:56:40 INFO - Cleaning up... 16:56:40 INFO - Return code: 0 16:56:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f162d306f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:56:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:56:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:56:40 INFO - Using env: {'DISPLAY': ':0', 16:56:40 INFO - 'HOME': '/home/cltbld', 16:56:40 INFO - 'LANG': 'en_US.UTF-8', 16:56:40 INFO - 'LANGUAGE': 'en_US:en', 16:56:40 INFO - 'LOGNAME': 'cltbld', 16:56:40 INFO - 'MAIL': '/var/mail/cltbld', 16:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:40 INFO - 'MOZ_NO_REMOTE': '1', 16:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:40 INFO - 'NO_EM_RESTART': '1', 16:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:56:40 INFO - 'PWD': '/builds/slave/test-pgo', 16:56:40 INFO - 'SHELL': '/bin/bash', 16:56:40 INFO - 'SHLVL': '1', 16:56:40 INFO - 'TERM': 'linux', 16:56:40 INFO - 'TMOUT': '86400', 16:56:40 INFO - 'USER': 'cltbld', 16:56:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:40 INFO - '_': '/tools/buildbot/bin/python'} 16:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:40 INFO - Downloading/unpacking flake8 16:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:56:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:56:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:42 INFO - no previously-included directories found matching 'docs/_build' 16:56:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:56:42 INFO - Running setup.py install for pep8 16:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:56:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:56:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:56:43 INFO - no previously-included directories found matching 'docs/_build' 16:56:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:56:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:56:43 INFO - Cleaning up... 16:56:43 INFO - Return code: 0 16:56:43 INFO - Running post-action listener: _resource_record_post_action 16:56:43 INFO - Running post-action listener: _start_resource_monitoring 16:56:43 INFO - Starting resource monitoring. 16:56:43 INFO - ##### 16:56:43 INFO - ##### Running install step. 16:56:43 INFO - ##### 16:56:43 INFO - Running pre-action listener: _resource_record_pre_action 16:56:43 INFO - Running main action method: install 16:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:56:43 INFO - Reading from file tmpfile_stdout 16:56:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:56:43 INFO - Reading from file tmpfile_stdout 16:56:43 INFO - Output received: 16:56:43 INFO - Usage: mozinstall [options] installer 16:56:43 INFO - Options: 16:56:43 INFO - -h, --help show this help message and exit 16:56:43 INFO - -d DEST, --destination=DEST 16:56:43 INFO - Directory to install application into. [default: 16:56:43 INFO - "/builds/slave/test-pgo"] 16:56:43 INFO - --app=APP Application being installed. [default: firefox] 16:56:43 INFO - mkdir: /builds/slave/test-pgo/build/application 16:56:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:56:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:56:59 INFO - Reading from file tmpfile_stdout 16:56:59 INFO - Output received: 16:56:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:56:59 INFO - Running post-action listener: _resource_record_post_action 16:56:59 INFO - ##### 16:56:59 INFO - ##### Running run-tests step. 16:56:59 INFO - ##### 16:56:59 INFO - Running pre-action listener: _resource_record_pre_action 16:56:59 INFO - Running main action method: run_tests 16:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:56:59 INFO - Python 2.7.3 16:56:59 INFO - Return code: 0 16:56:59 INFO - grabbing minidump binary from tooltool 16:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f1920>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f2cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:56:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:56:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:56:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:59 INFO - Return code: 0 16:56:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:56:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:56:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:56:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:57:00 INFO - Return code: 0 16:57:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:57:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:57:00 INFO - Using env: {'DISPLAY': ':0', 16:57:00 INFO - 'HOME': '/home/cltbld', 16:57:00 INFO - 'LANG': 'en_US.UTF-8', 16:57:00 INFO - 'LANGUAGE': 'en_US:en', 16:57:00 INFO - 'LOGNAME': 'cltbld', 16:57:00 INFO - 'MAIL': '/var/mail/cltbld', 16:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:00 INFO - 'MOZ_NO_REMOTE': '1', 16:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:57:00 INFO - 'NO_EM_RESTART': '1', 16:57:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:57:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:57:00 INFO - 'SHELL': '/bin/bash', 16:57:00 INFO - 'SHLVL': '1', 16:57:00 INFO - 'TERM': 'linux', 16:57:00 INFO - 'TMOUT': '86400', 16:57:00 INFO - 'USER': 'cltbld', 16:57:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436', 16:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:00 INFO - '_': '/tools/buildbot/bin/python'} 16:57:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:57:00 INFO - mozversion application_buildid: 20160306143005 16:57:00 INFO - mozversion application_changeset: b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad 16:57:00 INFO - mozversion application_display_name: Nightly 16:57:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:57:00 INFO - mozversion application_name: Firefox 16:57:00 INFO - mozversion application_remotingname: firefox 16:57:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:57:00 INFO - mozversion application_vendor: Mozilla 16:57:00 INFO - mozversion application_version: 47.0a1 16:57:00 INFO - mozversion platform_buildid: 20160306143005 16:57:00 INFO - mozversion platform_changeset: b6acf4d4fc20431a8ae14bf32cdc6e43a9c0f9ad 16:57:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:57:00 INFO - mozversion platform_version: 47.0a1 16:57:00 INFO - using testdate: 1457312220 16:57:00 INFO - actual date: 1457312220 16:57:00 INFO - starting webserver on 'localhost:35428' 16:57:00 INFO - SUITE-START | Running 2 tests 16:57:00 INFO - TEST-START | dromaeo_css 16:57:00 INFO - operating with platform_type : linux_ 16:57:00 INFO - Initialising browser for dromaeo_css test... 16:57:00 INFO - TEST-INFO | started process 6300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkXISzr/profile http://localhost:35428/getInfo.html) 16:57:05 INFO - PROCESS | 6300 | 16:57:05 INFO - PROCESS | 6300 | (process:6384): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:06 INFO - PROCESS | 6300 | __metrics Screen width/height:1600/1200 16:57:06 INFO - PROCESS | 6300 | colorDepth:24 16:57:06 INFO - PROCESS | 6300 | Browser inner width/height: 1024/697 16:57:06 INFO - PROCESS | 6300 | __metrics 16:57:06 ERROR - PROCESS | 6300 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:57:07 INFO - TEST-INFO | 6300: exit 0 16:57:07 INFO - Browser initialized. 16:57:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:57:07 INFO - TEST-INFO | started process 6435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkXISzr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:09 INFO - PROCESS | 6435 | 16:57:09 INFO - PROCESS | 6435 | (process:6497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:57:19 INFO - PROCESS | 6435 | RSS: Main: 165605376 16:57:19 INFO - PROCESS | 6435 | 16:58:09 INFO - PROCESS | 6435 | 1457312289083 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:00:18 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35428/tests/dromaeo/cssquery-ext.html) 17:00:19 INFO - PROCESS | 6435 | RSS: Main: 172089344 17:00:19 INFO - PROCESS | 6435 | 17:03:21 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-ext.html (next: http://localhost:35428/tests/dromaeo/cssquery-jquery.html) 17:03:21 INFO - PROCESS | 6435 | RSS: Main: 168026112 17:03:21 INFO - PROCESS | 6435 | 17:06:23 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35428/tests/dromaeo/cssquery-mootools.html) 17:06:24 INFO - PROCESS | 6435 | RSS: Main: 169648128 17:06:24 INFO - PROCESS | 6435 | 17:09:26 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35428/tests/dromaeo/cssquery-prototype.html) 17:09:26 INFO - PROCESS | 6435 | RSS: Main: 168189952 17:09:26 INFO - PROCESS | 6435 | 17:12:29 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35428/tests/dromaeo/cssquery-yui.html) 17:12:29 INFO - PROCESS | 6435 | RSS: Main: 168431616 17:12:29 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | Cycle 1(1): loaded http://localhost:35428/tests/dromaeo/cssquery-yui.html (next: http://localhost:35428/tests/dromaeo/cssquery-dojo.html) 17:15:32 INFO - PROCESS | 6435 | RSS: Main: 171560960 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | __start_tp_report 17:15:32 INFO - PROCESS | 6435 | _x_x_mozilla_page_load 17:15:32 INFO - PROCESS | 6435 | _x_x_mozilla_page_load_details 17:15:32 INFO - PROCESS | 6435 | |i|pagename|runs| 17:15:32 INFO - PROCESS | 6435 | |0;dojo.html;3160.399524090423;3214.6303175134867;3224.1294850390395;3248.5614442050314;3276.311974485358;5170.560502357304;5285.18079697647;5286.920696189551;5289.391719952207;5364.946350536494;5286.867828304285;5291.259223708684;5293.841184764454;5378.8924221515645;5383.353997520293;4819.662623616348;4863.173260545698;4902.754862256891;4902.852914412573;4988.176950803113;4810.11012962603;4932.087563800708;4969.776360063788;4975.303457515933;4976.253561965698;4758.976205118952;4853.39332583427;4886.096072226632;4891.046245982035;4914.066327397801;4829.782659780319;4857.61139108874;4874.902501949941;4894.681845680019;4927.433345165316;4846.369971903665;4853.514648535118;4862.343583616202;4862.513748625144;4878.8292409765845;5028.094942910275;5088.949110508885;5100.260462232993;5181.559567436772;5221.973890130525;5645.576581756343;5712.885742285131;5727.684977326246;5755.194272801811;5757.913631295534;5622.184783206453;5776.566757493205;5784.8843023139725;5792.507636850873;5813.6221145625395;5338.332708411449;5361.678299302093;5386.434424385461;5386.649867758583;5440.265564148829;5821.621594596338;5852.063669812895;5854.970725146347;5861.472467477947;5871.853203669857;5450.591205659592;5561.805336813192;5616.831495055155;5617;5626.915596266059;5637.661740295595;5650.406707295757;5653.9151912721345;5656.43435656431;5704.771809127671;5552.5280351169795;5622.269105016322;5631.971840140855;5654.802081927113;5685.829425117253;5537.307836520435;5666.716664166775;5690.2033715279895;5715.114157305624;5740.856478588069;4308.439902812677;4353.194658988097;4362.302031674917;4369.759663218553;4373.387725718402;3902.6097390261316;3908;3921.0785465415606;3930.2139572085125;3939.7045221607923;5307.787688492494;5417.349918009785;5461.672299661954;5490.121580547093;5493.2034854945805;5716.685582292931;5747.626404283792;5750.137479378127;5753.539716822645;5766.855828604318;5412.296401467784;5449.836504904859;5466.371367292732;5471.343438787291;5473.2063850742215;4770.427548694179;4820.25286080658;4858.975705121452;4889.951100489021;4903.5586797188425;6001.459868611846;6028.216331876915;6036.396360364016;6065.454109130112;6069.726862291119;5739.7417116229035;5746.310442746897;5749.993751093625;5750.367459579526;5788.884222315446;5860.912086318624;5988.700564971821;5995.940040599538;6018.638881667114;6093.512518998381;5572.832815015556;5584.106542953108;5599.580031497572;5604.523615492729;5627.831165065055;5643.492085712305;5652;5695.715214239354;5698.6010979232715;5700.486956173964;5461.9453805461435;5476.151196564539;5569.081101618188;5616.85957851057;5672.205891175321;5475.178723191553;5515.255440515479;5515.586331025109;5516.972415137899;5519.39286678457;5333.679979201261;5383.757730902197;5427.728613569385;5440.945590544202;5465.781368745205;5546.362168350692;5584.720763961867;5605.243292155506;5629.099344105088;5632.7746890123935;5368.302120724281;5451.3458384994055;5484.753186106715;5501.944980550144;5519.337679478488 17:15:32 INFO - PROCESS | 6435 | |1;ext.html;522.2010324203968;535.9249705041295;547.926029985952;548.311868604901;558.3021223470662;35823;36237.81881090591;36462.8176859116;36790.08024799378;36804;37418.81290593543;37786;37865.62134378655;37872.24255514888;37878;8271.2142346477;8432.873506897371;8463.95768021159;8483.448575842582;8483.490990540557;8410.158984101603;8585.785355366103;8591.441556298852;8611.870821937677;8624.870626940601;8558.957205213965;8704.608292626815;8714.651413943466;8717.476951382905;8719.825603487927;8518.616662250182;8654.913450865473;8668.349873759431;8674.04585495598;8683.088275731052;8390.580470976487;8488.53313067781;8514.57427128641;8527.701530446404;8534.146585341477;37290;37646.623533764585;37667.81166094179;37780.811095944344;37850;3344.8037857458603;3609.3503169429755;3660.3045421369857;4070.796460177009;4259.297215959363;28633.856830715922;29556.852215738785;29743.70256297431;29747.40505189884;29782.76629252793;3291.703746662788;3398.150462384404;3400.1499625093725;3467.289205712848;3487.5989261235027;269845;273590;274734.999999998;276026;276157.61921190465;63495.6825215871;63609.68195158995;63694;63873.99999999907;63895.68052159803;66183.66908165428;66715.66642166855;66728.66635666888;66730;66809.66595166993;14490.492832750802;14701.632459188391;14765.852341476448;14773;15292.311845966735;11542.422878856192;11657.59198428068;11677.824832627517;11696.298222106701;11752.23610465334;20572.485687857923;20601.587968240852;20807.68788468174;20878;21099.261525846523;7827.412944029106;8086.959565202254;8141.592920353959;8220.972378452694;8317.792055198548;968.4528241543505;979.9216062714966;986.7039888033561;1020.1125021231428;1125.8986691197667;28780;28965.710342896302;29069.854650727033;29091.27271818179;29265.85367073151;1080.529969463286;1158.5655379232787;1179.6402097360217;1195.5755706723987;1199.4122879789015;15108.697826043417;15118.697626047637;15294.694106117815;15328.770068448983;15345.693086138437;287387;290101;291732;291767;292138;50599.494005060216;52038.47961520412;52085.739571302656;52212.21681674778;52263.73868130635;1334.8932085433141;1358.9796153057712;1368.1996032321006;1371.3965855023757;1374.6357215337944;27435;27832.44335113246;28011.859940700982;28430.57354139731;28547.857260713565;46995;47184.52815471801;47274.29088563605;47345.289820652026;47443.76278118725;268932;273285;275947;276736;276960;31875.043748687578;32254.19364515906;32280.35439291248;32320.83839580787;32333.35333293274;42295.7885210572;43395;43459.78270108629;43746.12507749891;43809.78095109504;36379.45430818593;36580.634193658785;36846.631533685395;36889.63110368862;37099;35372.469412958315;35791;36273.81863090667;36617.08457288589;36830.63169368272;35165;35987;36225.637743622225;36548.63451365452;36555.08612284714;31740.04779856608;32666.51000235046;32844.1788955278;32868.83565582253;33304;25174;25281.241562753148;25302.620460693473;25372.619410709223;25618.359541011625 17:15:32 INFO - PROCESS | 6435 | |2;jquery.html;345.4127982429869;349.08887802834613;359.29578027066947;360.1015466411303;368.4197389112147;16373.345066197353;16725;17089.31642734292;17184.742228866577;17269.30922763091;16607.584810379718;16828.495145145636;16866.409675661354;17071.14644267788;17195.14024298786;5168.173092305232;5348.545373643245;5379.488948549882;5435.891282174364;5637.379888212294;5235.188545775411;5365.409804921455;5381.273528073699;5383.057964856154;5417.241586177938;5621.4659607337235;5644;5656.123300888369;5658.632188907728;5667.291588551431;5536.2249285099715;5622.465865742748;5626.774929002855;5629.789595237024;5638.943610563903;5475.0418676731415;5539.25220095286;5552;5555.611107222496;5562.4993750562235;12850.293233872133;12931.288779117145;13104.86895131046;19601.607967840708;20209.797902021084;2010.9095090720953;2059.5571952030236;2117.46004768783;2141.239859849762;2161.448830548216;9188.44869307837;9396.859047114298;9408.153266206005;9647.469389183592;9699.321047526675;1832.890026598395;1841.1898764543557;1868.8785228960073;1880.0693656639914;1922.6731455652573;50370.24444633334;55375.72312138454;58844.11733823996;61902.690486547726;64911;9933.205343572497;10054.145397641283;10233.130183934449;10363.689089327332;10525.84211236832;13656.590302290948;13678.316084195949;13792.724145517033;13831.723365532633;13849.51526696581;7373.410127189812;7424;7465.58939258346;7514.849703005909;7643.121041080236;7051.400630946325;7153.642317884189;7206;7219.169795473483;7293.1248250209255;4507.797149128297;4536.455625324982;4589.403377560896;4615.2384856498975;4667.649926255544;1857.5449014991143;1868.5422071592548;1873.4847916822982;1907.3038341005433;1911;886.7339798060556;944.9291303152291;971.2084651009404;978.6819283732815;992.3301771304341;15503.767443488357;16089.597760055858;16322.75515867263;16539.25573349202;16637.91681041587;881.9073997230198;892.2995448572968;917.0966597901062;949.4588084791602;964.9674847912667;7170.498065135391;9411.952940235393;9419.90580094204;9484.430934143973;9513.762155946157;383989;388616;390426;390712;391148;68133;70215;70491;71715;72632;993.3046867192994;997.7655251016006;998.6454808543008;1011.5346940407347;1013.1489548779061;14189.432422703389;14448.927755361156;14588;14764.704705906037;14964.476243331432;31455.37089258248;32729.18177045593;33007.174820629676;33085.50371744474;33218.16954576058;45479.31781023354;45536;45749.31376029429;45941.31088033749;46273;7520.661570229462;7580.241975802375;7618.200088990798;7720.266574675621;7727.0727512696585;9928.67389424522;11535.538578456768;11782;11782.764344713229;12339.197952133083;9890.45602491841;10221.591136354462;10267.486625668538;10353.84469232947;10521.421321827373;10103.898961010296;10140.391576505433;10443.861635969626;10476.738081548023;10533.10468610146;8145.551994640115;8194.713185038734;8197.303229225583;8532;10408.219383546113;10607.242117049469;10687.89312106869;10934.507947142556;11144.219904606924;11286.92774186451;11480.94259528697;11571.6528504145;11666.300021998708;11709.707257318294;11787.351695656822 17:15:32 INFO - PROCESS | 6435 | |3;mootools.html;1467.2003757951916;1473.2412807404185;1673.3390310827224;1830.789459212191;1859.20054376618;7070.151581810177;7745.573993430359;7913.802154946122;8094.271515563598;8147;7752.689892404297;7818.179091195428;7850.489718168315;7903.1701671324545;7914.683412663501;2246.7079279693658;2269.137727663494;2278.906125059972;2288.9771102289014;2293.1056887813766;2315.2012555668266;2333.5449587330477;2372.063035101134;2380.4643955110137;2382.7617238276207;2368.3842201027683;2385.2367242482414;2397;2415.6497307890345;2416.6495858100566;2392.5932591459496;2401.903923843044;2402.627592723131;2420.5521978434044;2424.0425032112394;2315.120254303354;2337.8947947342413;2344.9564943600103;2353.7175538935267;2362.692849929498;7967.28294453502;8072;8079;8090.514569125871;8091;5005.824796132154;5055.3933527976515;5089.185730283174;5128.640995130342;5133.974330128362;3293.4730443128983;3322.5846769153854;3361.126107212118;3361.6134144573443;3397.0997685613333;1101.6034227678028;1109.4563663804759;1113.8050841102856;1116.1851848150895;1117.793208256475;10961.83557246642;11009.889901100967;11020.779584408347;11067.169962252783;11077.058450031756;4581.679282450264;4585.403897493305;4637.930431043537;4665.323528088408;4677.111348843709;9570.186534144537;9574.281928855364;9575.707279517315;9580.13778759915;9596.280278979104;5020.59835213182;5045.571126454292;5046.798128074909;5053.620978426633;5078.5937125029905;4030.5163380394542;4327.112941846914;4361.781910904442;4520.254158063883;4523.909521809545;3873;3905.3165696003084;3922.686185105185;3956.4658771065538;3962.722609417313;1232.975340493185;1238.9008879289636;1251.217988757027;1261.8611952685196;1262.211118051218;1310.967225819362;1317.466426097432;1320.7886738121854;1336.2717319061135;1347.158026233604;7160.892586611205;7207.783766487014;7269.454790890704;7308.817279568053;7328.083989501312;510.57112025898425;516.4731973387125;520.5081198267601;520.565327951165;525.385299199937;5308.362996440452;5308.973455132699;5348.304720386403;5356.276902618097;5379.65032272901;9291.117343852324;9454.669086582075;9466.337356384987;9468.479233642216;9593.952030239943;9428.90571094294;9431.151196392357;9436.245100391952;9445;9453.101955314234;7242.6378681065735;7446.218147094585;7468.253174682488;7533.660985255677;7567.432442566829;7282.781516554512;7306.853862922605;7339.559626422431;7340.70637174507;7405.407567394488;8517.105703901248;8626.91373086261;8757.211850933192;8759.12408759119;8910.955445222991;8938.41900276506;8970.820583588162;9038.728838134866;9044.592993315448;9192.448453092567;6321.652309123042;6707.865842683216;6852.314768523108;7027.543209691354;7126.216116227107;7549.0941087069905;7588.354989825927;7593.468457207942;7596.392288616787;7599.4680372373405;6734.4612431004425;6891.552049116792;6915.377616014583;6960.79117626472;7027.367536921702;6669.2997235289595;6728.596284222962;6731.394174524316;6861.245263021164;6909.998050282781;6773.424258938046;6840;6840.657967101525;7007.194172670208;7204.639768011473;6425.935740642533;6447.387498187664;6453.903191452038;6470.773522926675;6482.611043337415;6614.404703576702;6696.83257918556;6707.832304192434;6720.1599800025;6723.394894459522 17:15:32 INFO - PROCESS | 6435 | |4;prototype.html;334.585114458072;345.29904294282613;351.1799947123467;357.44417430894947;358.1744079895839;6168.907466388007;6225.035119556464;6233.189685340911;6252.124702541642;6252.593581417211;6180.289266734327;6185.257769067707;6214.502839772818;6220.533459990496;6238.095476155955;4554.590086892179;4650.395448591678;4770.833020844271;4772.355731976173;4784.354112194844;4727.810887564493;4736.97631511842;4747.1692453820615;4756.548127927858;4764.047190561884;4718.693284936468;4718.97640511797;4728.66899317048;4728.716277023373;4737.7631118444115;4713.835015774432;4724.811007559693;4733.502982186872;4781.0676918001;4789.640776941744;4185.602367775056;4203.91592168155;4208.305629571117;4216.789160541991;4228.4080228768;5834.620749651259;5938.6436813791315;5942.405759424067;5952.255968003999;5954.2259506264345;5527.50252477279;5550.084236101038;5568.582356323252;5578.693171875545;5578.9163162552595;6550.312217217172;6561.573497722633;6570.375814297634;6589.341065893373;6594.736210551572;4670.159371313162;4673.719576825368;4673.859784206479;4678.087772884289;4681.625469962395;6810.727570897158;6847.623380714109;6877.724891004354;6905.37851593359;6910.308969103049;4411.139827733561;4587.03672228829;4761.309610106515;4781.880452988703;4794.208955522369;4624.583787459078;4633.957359594065;4656.650751193674;4659.347691323217;4682;5406.08096623575;5424.538914192338;5426.647267927572;5428.077226871442;5442.292501974797;6584.176977877765;6597.274299827015;6627.668616569249;6629.1382120325015;6645.501587380966;1617.5713435939485;1638.5412084616326;1640.442249635106;1642.3020216407979;1655.9236496277515;1070.5610699613121;1090.7491277006334;1096.780643871229;1104.4753741972659;1122.0630773304383;6355.841103972438;6361.61830290184;6379.979203327445;6382.808515744442;6392.808215753535;6747.156605424322;6799.354061364163;6806.489513286424;6816.522843401013;6829.146356705412;6280.968595157086;6435.22777266731;6459.224893012869;6459.61242325462;6466.708998095097;3688;3704.7036237100965;3711.851525938986;3715.3498137825773;3723.236736469017;7299.8540029200185;7331.193568707438;7348.889766653505;7364.410847132217;7365.668544915492;7032.964835175791;7051.224365319811;7061.293870613001;7070.222275549685;7083.822904427328;7065.081539399948;7316.634168291458;7342.375898048619;7342.449316301192;7354.117505899327;6808.148981377328;6857.2114206866845;6864.38220560152;6865.073215115895;6876.69054892521;6800.31996800316;6804.4896632753735;6833.214180369321;6836.692348844414;6836.794896153124;7261.164966028974;7296.270372962661;7337.339639432476;7343.44924130703;7348.1182258129365;4497.527759585197;4669.696469729457;4678.041001594597;4686.320483529801;4694.201985662514;6875.209350924708;6881.243063262937;6890.827729306808;6902.965485172542;6911;6629.43649789754;6656.633885136364;6656.800295991128;6667.533272670867;6675.6995935184;6672.799816005528;6674.26583075871;6681.933180668326;6688.063671086149;6694;6391.744330226739;6565.310642382481;6572.474202063919;6577.704003319766;6586.637734924433;6696;6726.6972986216715;6727.192736871607;6732.495062870402;6739.123913891162;6484.319146489551;6558.147440832661;6559.983202603604;6570.310117437601;6573.04690819838 17:15:32 INFO - PROCESS | 6435 | |5;yui.html;671.8118926700524;678.9932100678993;717.7057406463348;720.4632548751181;721.58508857407;12497.312647804367;13180.604581862548;13291.268980206085;13569.52506662267;14845.109293442401;14106.788398174036;14171.78742318866;14242.501512447066;14248.28758562073;14298.499552515665;835.8537255980209;839.1314988986401;842.4103127810527;843.9240468357847;846.187659846545;844.3245403677065;844.7423535821572;846.2341580869323;847.0682249525504;848.8896443462341;891.242443922667;899.7570655922897;900.7703035725914;902.2105657549644;902.463034494478;882.4396508217264;883.337496877342;886.601029536711;889.5152142082613;890.6214858685065;653.5425202358368;656.0159760359461;656.2190992718649;656.3370995294787;657.8190997475684;13294.135881167693;13389.531366402129;13634.522791702342;14236.074655147382;14256.928715356356;12933.641967593456;13173.407196676173;13273.53542626013;13492.662683432993;13787.103838250481;10557.736056598647;10594.62918797846;10733.62432314873;10738.516766745515;10824.40465774382;3597.8560857565667;3645.8359373827975;3661.3226553087766;3666.468362087509;3791.469194312798;46309.30536041962;46361.536384636056;47148.05703885938;48131.75934120342;48598.7570062151;10591.523381447852;10720.142388608892;10733.355998640107;10740.194485413625;10830.241883068267;18620.06899655012;18708.906455467637;18716.344927927457;18721.344752933855;18791.15439805212;7742.7677169685;7886.290233878864;7933.920660793318;7964;7979.20207979209;4321.719088259253;4518.012074687127;4544.522825103382;4554.248548989446;4583.427071616048;3212.245122396235;3246.269589342426;3247.1395080303737;3249.52881832133;3252.447083995726;609.326694003129;613.4846728747873;615.806021103351;617.9474744646666;623.2147494157394;645.6836150286326;645.7107770317078;648.5427773419727;662.2053535757015;663.3598577372859;8523.786905327417;8636.69771558005;8638.524881131472;8937.329700272505;8953.418027828171;640.679660169915;645.515863102673;660.2110477978865;660.3231687520234;669;3942.2312649033165;4085.775282359439;4086.1010577672864;4106.650934670527;4252.213340532012;54151;56715;56769.7161514198;57048;57365;47956.5204347959;48199.75900120477;48415.273770893466;49733;49924.50075499271;44916.3262551062;45203;45809.31286030712;45811.083778324246;46164;7974.362051035787;8189.181081892001;8201.26188643025;8223.09545949957;8253.504789712637;34491.48262776111;34962.9511114667;35321.646783532866;35975.28049439049;37088.81455592705;40659.59340406676;43143;44245.778771105935;44259;44968.77515612401;9980.201583873128;10035.749106272402;10562.207834412297;10693.839592405964;10832.350058996486;11225.66323010311;11387.601433949772;11463.197576169589;11591.050806873884;11600.187986841178;9963.153131983572;10054.748631284276;10098.747531311776;10118.392896426238;10309.165144300252;10733.463326833784;10794.136469082612;11233.662990109982;11457.427128643702;11476.540938362372;9701.320907536687;9725;9861.457619830979;10831.350118992885;10841.349519028883;9182.770430739285;9289.800070815429;9357.85963210566;9463.697352229114;9699.127078562964;8545.487270763773;8724.384020413056;8938.553072346227;9230.261579073793;9456.716298511055 17:15:32 INFO - PROCESS | 6435 | __end_tp_report 17:15:32 INFO - PROCESS | 6435 | __start_cc_report 17:15:32 INFO - PROCESS | 6435 | _x_x_mozilla_cycle_collect,352 17:15:32 INFO - PROCESS | 6435 | __end_cc_report 17:15:32 INFO - PROCESS | 6435 | __startTimestamp1457313332284__endTimestamp 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | ------- Summary: start ------- 17:15:32 INFO - PROCESS | 6435 | Number of tests: 6 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#0] dojo.html Cycles:165 Average:5302.81 Median:5475.18 stddev:588.84 (10.8%) stddev-sans-first:566.15 17:15:32 INFO - PROCESS | 6435 | Values: 3160.4 3214.6 3224.1 3248.6 3276.3 5170.6 5285.2 5286.9 5289.4 5364.9 5286.9 5291.3 5293.8 5378.9 5383.4 4819.7 4863.2 4902.8 4902.9 4988.2 4810.1 4932.1 4969.8 4975.3 4976.3 4759.0 4853.4 4886.1 4891.0 4914.1 4829.8 4857.6 4874.9 4894.7 4927.4 4846.4 4853.5 4862.3 4862.5 4878.8 5028.1 5088.9 5100.3 5181.6 5222.0 5645.6 5712.9 5727.7 5755.2 5757.9 5622.2 5776.6 5784.9 5792.5 5813.6 5338.3 5361.7 5386.4 5386.6 5440.3 5821.6 5852.1 5855.0 5861.5 5871.9 5450.6 5561.8 5616.8 5617.0 5626.9 5637.7 5650.4 5653.9 5656.4 5704.8 5552.5 5622.3 5632.0 5654.8 5685.8 5537.3 5666.7 5690.2 5715.1 5740.9 4308.4 4353.2 4362.3 4369.8 4373.4 3902.6 3908.0 3921.1 3930.2 3939.7 5307.8 5417.3 5461.7 5490.1 5493.2 5716.7 5747.6 5750.1 5753.5 5766.9 5412.3 5449.8 5466.4 5471.3 5473.2 4770.4 4820.3 4859.0 4890.0 4903.6 6001.5 6028.2 6036.4 6065.5 6069.7 5739.7 5746.3 5750.0 5750.4 5788.9 5860.9 5988.7 5995.9 6018.6 6093.5 5572.8 5584.1 5599.6 5604.5 5627.8 5643.5 5652.0 5695.7 5698.6 5700.5 5461.9 5476.2 5569.1 5616.9 5672.2 5475.2 5515.3 5515.6 5517.0 5519.4 5333.7 5383.8 5427.7 5440.9 5465.8 5546.4 5584.7 5605.2 5629.1 5632.8 5368.3 5451.3 5484.8 5501.9 5519.3 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#1] ext.html Cycles:180 Average:45395.69 Median:36255.82 stddev:73014.11 (201.4%) stddev-sans-first:73141.19 17:15:32 INFO - PROCESS | 6435 | Values: 522.2 535.9 547.9 548.3 558.3 35823.0 36237.8 36462.8 36790.1 36804.0 37418.8 37786.0 37865.6 37872.2 37878.0 8271.2 8432.9 8464.0 8483.4 8483.5 8410.2 8585.8 8591.4 8611.9 8624.9 8559.0 8704.6 8714.7 8717.5 8719.8 8518.6 8654.9 8668.3 8674.0 8683.1 8390.6 8488.5 8514.6 8527.7 8534.1 37290.0 37646.6 37667.8 37780.8 37850.0 3344.8 3609.4 3660.3 4070.8 4259.3 28633.9 29556.9 29743.7 29747.4 29782.8 3291.7 3398.2 3400.1 3467.3 3487.6 269845.0 273590.0 274735.0 276026.0 276157.6 63495.7 63609.7 63694.0 63874.0 63895.7 66183.7 66715.7 66728.7 66730.0 66809.7 14490.5 14701.6 14765.9 14773.0 15292.3 11542.4 11657.6 11677.8 11696.3 11752.2 20572.5 20601.6 20807.7 20878.0 21099.3 7827.4 8087.0 8141.6 8221.0 8317.8 968.5 979.9 986.7 1020.1 1125.9 28780.0 28965.7 29069.9 29091.3 29265.9 1080.5 1158.6 1179.6 1195.6 1199.4 15108.7 15118.7 15294.7 15328.8 15345.7 287387.0 290101.0 291732.0 291767.0 292138.0 50599.5 52038.5 52085.7 52212.2 52263.7 1334.9 1359.0 1368.2 1371.4 1374.6 27435.0 27832.4 28011.9 28430.6 28547.9 46995.0 47184.5 47274.3 47345.3 47443.8 268932.0 273285.0 275947.0 276736.0 276960.0 31875.0 32254.2 32280.4 32320.8 32333.4 42295.8 43395.0 43459.8 43746.1 43809.8 36379.5 36580.6 36846.6 36889.6 37099.0 35372.5 35791.0 36273.8 36617.1 36830.6 35165.0 35987.0 36225.6 36548.6 36555.1 31740.0 32666.5 32844.2 32868.8 33304.0 25174.0 25281.2 25302.6 25372.6 25618.4 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#2] jquery.html Cycles:180 Average:23502.46 Median:4522.13 stddev:63819.29 (1411.3%) stddev-sans-first:63974.64 17:15:32 INFO - PROCESS | 6435 | Values: 345.4 349.1 359.3 360.1 368.4 16373.3 16725.0 17089.3 17184.7 17269.3 16607.6 16828.5 16866.4 17071.1 17195.1 5168.2 5348.5 5379.5 5435.9 5637.4 5235.2 5365.4 5381.3 5383.1 5417.2 5621.5 5644.0 5656.1 5658.6 5667.3 5536.2 5622.5 5626.8 5629.8 5638.9 5475.0 5539.3 5552.0 5555.6 5562.5 12850.3 12931.3 13104.9 19601.6 20209.8 2010.9 2059.6 2117.5 2141.2 2161.4 9188.4 9396.9 9408.2 9647.5 9699.3 1832.9 1841.2 1868.9 1880.1 1922.7 50370.2 55375.7 58844.1 61902.7 64911.0 9933.2 10054.1 10233.1 10363.7 10525.8 13656.6 13678.3 13792.7 13831.7 13849.5 7373.4 7424.0 7465.6 7514.8 7643.1 7051.4 7153.6 7206.0 7219.2 7293.1 4507.8 4536.5 4589.4 4615.2 4667.6 1857.5 1868.5 1873.5 1907.3 1911.0 886.7 944.9 971.2 978.7 992.3 15503.8 16089.6 16322.8 16539.3 16637.9 881.9 892.3 917.1 949.5 965.0 7170.5 9412.0 9419.9 9484.4 9513.8 383989.0 388616.0 390426.0 390712.0 391148.0 68133.0 70215.0 70491.0 71715.0 72632.0 993.3 997.8 998.6 1011.5 1013.1 14189.4 14448.9 14588.0 14764.7 14964.5 31455.4 32729.2 33007.2 33085.5 33218.2 45479.3 45536.0 45749.3 45941.3 46273.0 7520.7 7580.2 7618.2 7720.3 7727.1 9928.7 11535.5 11782.0 11782.8 12339.2 9890.5 10221.6 10267.5 10353.8 10521.4 10103.9 10140.4 10443.9 10476.7 10533.1 8145.6 8194.7 8197.3 8532.0 10408.2 10607.2 10687.9 10934.5 11144.2 11286.9 11480.9 11571.7 11666.3 11709.7 11787.4 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#3] mootools.html Cycles:180 Average:5570.23 Median:6373.79 stddev:2877.34 (45.1%) stddev-sans-first:2868.89 17:15:32 INFO - PROCESS | 6435 | Values: 1467.2 1473.2 1673.3 1830.8 1859.2 7070.2 7745.6 7913.8 8094.3 8147.0 7752.7 7818.2 7850.5 7903.2 7914.7 2246.7 2269.1 2278.9 2289.0 2293.1 2315.2 2333.5 2372.1 2380.5 2382.8 2368.4 2385.2 2397.0 2415.6 2416.6 2392.6 2401.9 2402.6 2420.6 2424.0 2315.1 2337.9 2345.0 2353.7 2362.7 7967.3 8072.0 8079.0 8090.5 8091.0 5005.8 5055.4 5089.2 5128.6 5134.0 3293.5 3322.6 3361.1 3361.6 3397.1 1101.6 1109.5 1113.8 1116.2 1117.8 10961.8 11009.9 11020.8 11067.2 11077.1 4581.7 4585.4 4637.9 4665.3 4677.1 9570.2 9574.3 9575.7 9580.1 9596.3 5020.6 5045.6 5046.8 5053.6 5078.6 4030.5 4327.1 4361.8 4520.3 4523.9 3873.0 3905.3 3922.7 3956.5 3962.7 1233.0 1238.9 1251.2 1261.9 1262.2 1311.0 1317.5 1320.8 1336.3 1347.2 7160.9 7207.8 7269.5 7308.8 7328.1 510.6 516.5 520.5 520.6 525.4 5308.4 5309.0 5348.3 5356.3 5379.7 9291.1 9454.7 9466.3 9468.5 9594.0 9428.9 9431.2 9436.2 9445.0 9453.1 7242.6 7446.2 7468.3 7533.7 7567.4 7282.8 7306.9 7339.6 7340.7 7405.4 8517.1 8626.9 8757.2 8759.1 8911.0 8938.4 8970.8 9038.7 9044.6 9192.4 6321.7 6707.9 6852.3 7027.5 7126.2 7549.1 7588.4 7593.5 7596.4 7599.5 6734.5 6891.6 6915.4 6960.8 7027.4 6669.3 6728.6 6731.4 6861.2 6910.0 6773.4 6840.0 6840.7 7007.2 7204.6 6425.9 6447.4 6453.9 6470.8 6482.6 6614.4 6696.8 6707.8 6720.2 6723.4 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#4] prototype.html Cycles:180 Average:5563.71 Median:6318.40 stddev:1703.24 (27.0%) stddev-sans-first:1662.18 17:15:32 INFO - PROCESS | 6435 | Values: 334.6 345.3 351.2 357.4 358.2 6168.9 6225.0 6233.2 6252.1 6252.6 6180.3 6185.3 6214.5 6220.5 6238.1 4554.6 4650.4 4770.8 4772.4 4784.4 4727.8 4737.0 4747.2 4756.5 4764.0 4718.7 4719.0 4728.7 4728.7 4737.8 4713.8 4724.8 4733.5 4781.1 4789.6 4185.6 4203.9 4208.3 4216.8 4228.4 5834.6 5938.6 5942.4 5952.3 5954.2 5527.5 5550.1 5568.6 5578.7 5578.9 6550.3 6561.6 6570.4 6589.3 6594.7 4670.2 4673.7 4673.9 4678.1 4681.6 6810.7 6847.6 6877.7 6905.4 6910.3 4411.1 4587.0 4761.3 4781.9 4794.2 4624.6 4634.0 4656.7 4659.3 4682.0 5406.1 5424.5 5426.6 5428.1 5442.3 6584.2 6597.3 6627.7 6629.1 6645.5 1617.6 1638.5 1640.4 1642.3 1655.9 1070.6 1090.7 1096.8 1104.5 1122.1 6355.8 6361.6 6380.0 6382.8 6392.8 6747.2 6799.4 6806.5 6816.5 6829.1 6281.0 6435.2 6459.2 6459.6 6466.7 3688.0 3704.7 3711.9 3715.3 3723.2 7299.9 7331.2 7348.9 7364.4 7365.7 7033.0 7051.2 7061.3 7070.2 7083.8 7065.1 7316.6 7342.4 7342.4 7354.1 6808.1 6857.2 6864.4 6865.1 6876.7 6800.3 6804.5 6833.2 6836.7 6836.8 7261.2 7296.3 7337.3 7343.4 7348.1 4497.5 4669.7 4678.0 4686.3 4694.2 6875.2 6881.2 6890.8 6903.0 6911.0 6629.4 6656.6 6656.8 6667.5 6675.7 6672.8 6674.3 6681.9 6688.1 6694.0 6391.7 6565.3 6572.5 6577.7 6586.6 6696.0 6726.7 6727.2 6732.5 6739.1 6484.3 6558.1 6560.0 6570.3 6573.0 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - PROCESS | 6435 | [#5] yui.html Cycles:180 Average:13634.64 Median:46335.42 stddev:15582.98 (33.6%) stddev-sans-first:15596.28 17:15:32 INFO - PROCESS | 6435 | Values: 671.8 679.0 717.7 720.5 721.6 12497.3 13180.6 13291.3 13569.5 14845.1 14106.8 14171.8 14242.5 14248.3 14298.5 835.9 839.1 842.4 843.9 846.2 844.3 844.7 846.2 847.1 848.9 891.2 899.8 900.8 902.2 902.5 882.4 883.3 886.6 889.5 890.6 653.5 656.0 656.2 656.3 657.8 13294.1 13389.5 13634.5 14236.1 14256.9 12933.6 13173.4 13273.5 13492.7 13787.1 10557.7 10594.6 10733.6 10738.5 10824.4 3597.9 3645.8 3661.3 3666.5 3791.5 46309.3 46361.5 47148.1 48131.8 48598.8 10591.5 10720.1 10733.4 10740.2 10830.2 18620.1 18708.9 18716.3 18721.3 18791.2 7742.8 7886.3 7933.9 7964.0 7979.2 4321.7 4518.0 4544.5 4554.2 4583.4 3212.2 3246.3 3247.1 3249.5 3252.4 609.3 613.5 615.8 617.9 623.2 645.7 645.7 648.5 662.2 663.4 8523.8 8636.7 8638.5 8937.3 8953.4 640.7 645.5 660.2 660.3 669.0 3942.2 4085.8 4086.1 4106.7 4252.2 54151.0 56715.0 56769.7 57048.0 57365.0 47956.5 48199.8 48415.3 49733.0 49924.5 44916.3 45203.0 45809.3 45811.1 46164.0 7974.4 8189.2 8201.3 8223.1 8253.5 34491.5 34963.0 35321.6 35975.3 37088.8 40659.6 43143.0 44245.8 44259.0 44968.8 9980.2 10035.7 10562.2 10693.8 10832.4 11225.7 11387.6 11463.2 11591.1 11600.2 9963.2 10054.7 10098.7 10118.4 10309.2 10733.5 10794.1 11233.7 11457.4 11476.5 9701.3 9725.0 9861.5 10831.4 10841.3 9182.8 9289.8 9357.9 9463.7 9699.1 8545.5 8724.4 8938.6 9230.3 9456.7 17:15:32 INFO - PROCESS | 6435 | -------- Summary: end -------- 17:15:32 INFO - PROCESS | 6435 | 17:15:32 INFO - TEST-INFO | 6435: exit 0 17:15:32 INFO - TEST-OK | dromaeo_css | took 1112124ms 17:15:32 INFO - TEST-START | kraken 17:15:32 INFO - operating with platform_type : linux_ 17:15:32 INFO - Initialising browser for kraken test... 17:15:32 INFO - TEST-INFO | started process 6669 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp83rc2M/profile http://localhost:35428/getInfo.html) 17:15:36 INFO - PROCESS | 6669 | 17:15:36 INFO - PROCESS | 6669 | (process:6741): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:37 INFO - PROCESS | 6669 | __metrics Screen width/height:1600/1200 17:15:37 INFO - PROCESS | 6669 | colorDepth:24 17:15:37 INFO - PROCESS | 6669 | Browser inner width/height: 1024/697 17:15:37 INFO - PROCESS | 6669 | __metrics 17:15:38 ERROR - PROCESS | 6669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:15:39 INFO - TEST-INFO | 6669: exit 0 17:15:39 INFO - Browser initialized. 17:15:39 INFO - Running cycle 1/1 for kraken test... 17:15:39 INFO - TEST-INFO | started process 6792 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp83rc2M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:41 INFO - PROCESS | 6792 | 17:15:41 INFO - PROCESS | 6792 | (process:6857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:51 INFO - PROCESS | 6792 | RSS: Main: 165720064 17:15:51 INFO - PROCESS | 6792 | 17:15:53 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35428/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:54 INFO - PROCESS | 6792 | RSS: Main: 169517056 17:15:54 INFO - PROCESS | 6792 | 17:15:56 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35428/tests/kraken/driver.html?testName=audio-dft) 17:15:57 INFO - PROCESS | 6792 | RSS: Main: 171806720 17:15:57 INFO - PROCESS | 6792 | 17:16:00 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35428/tests/kraken/driver.html?testName=audio-fft) 17:16:00 INFO - PROCESS | 6792 | RSS: Main: 166412288 17:16:00 INFO - PROCESS | 6792 | 17:16:02 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35428/tests/kraken/driver.html?testName=audio-oscillator) 17:16:03 INFO - PROCESS | 6792 | RSS: Main: 164814848 17:16:03 INFO - PROCESS | 6792 | 17:16:05 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:16:06 INFO - PROCESS | 6792 | RSS: Main: 166313984 17:16:06 INFO - PROCESS | 6792 | 17:16:09 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35428/tests/kraken/driver.html?testName=imaging-darkroom) 17:16:10 INFO - PROCESS | 6792 | RSS: Main: 168513536 17:16:10 INFO - PROCESS | 6792 | 17:16:13 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35428/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:14 INFO - PROCESS | 6792 | RSS: Main: 167964672 17:16:14 INFO - PROCESS | 6792 | 17:16:17 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35428/tests/kraken/driver.html?testName=json-parse-financial) 17:16:17 INFO - PROCESS | 6792 | RSS: Main: 168931328 17:16:17 INFO - PROCESS | 6792 | 17:16:19 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:19 INFO - PROCESS | 6792 | RSS: Main: 167366656 17:16:19 INFO - PROCESS | 6792 | 17:16:21 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:22 INFO - PROCESS | 6792 | RSS: Main: 167743488 17:16:22 INFO - PROCESS | 6792 | 17:16:24 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:25 INFO - PROCESS | 6792 | RSS: Main: 167473152 17:16:25 INFO - PROCESS | 6792 | 17:16:27 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:28 INFO - PROCESS | 6792 | RSS: Main: 168546304 17:16:28 INFO - PROCESS | 6792 | 17:16:30 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:31 INFO - PROCESS | 6792 | RSS: Main: 167485440 17:16:31 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | Cycle 1(1): loaded http://localhost:35428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35428/tests/kraken/driver.html?testName=ai-astar) 17:16:33 INFO - PROCESS | 6792 | RSS: Main: 170229760 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | __start_tp_report 17:16:33 INFO - PROCESS | 6792 | _x_x_mozilla_page_load 17:16:33 INFO - PROCESS | 6792 | _x_x_mozilla_page_load_details 17:16:33 INFO - PROCESS | 6792 | |i|pagename|runs| 17:16:33 INFO - PROCESS | 6792 | |0;ai-astar;114;106;110;112;113;124;111;111;117;111 17:16:33 INFO - PROCESS | 6792 | |1;audio-beat-detection;159;134;158;173;129;154;153;129;174;128 17:16:33 INFO - PROCESS | 6792 | |2;audio-dft;163;162;161;164;163;160;164;171;164;161 17:16:33 INFO - PROCESS | 6792 | |3;audio-fft;74;73;73;76;74;76;75;73;160;75 17:16:33 INFO - PROCESS | 6792 | |4;audio-oscillator;93;96;147;94;94;95;152;94;95;139 17:16:33 INFO - PROCESS | 6792 | |5;imaging-gaussian-blur;117;117;118;117;118;116;117;118;117;119 17:16:33 INFO - PROCESS | 6792 | |6;imaging-darkroom;147;147;147;148;148;148;147;148;148;149 17:16:33 INFO - PROCESS | 6792 | |7;imaging-desaturate;97;96;97;96;97;97;96;97;96;96 17:16:33 INFO - PROCESS | 6792 | |8;json-parse-financial;59;57;60;58;61;59;58;58;57;57 17:16:33 INFO - PROCESS | 6792 | |9;json-stringify-tinderbox;67;69;67;67;67;67;67;67;67;68 17:16:33 INFO - PROCESS | 6792 | |10;stanford-crypto-aes;90;91;91;84;92;83;83;82;84;84 17:16:33 INFO - PROCESS | 6792 | |11;stanford-crypto-ccm;128;118;117;118;120;119;132;118;121;117 17:16:33 INFO - PROCESS | 6792 | |12;stanford-crypto-pbkdf2;148;161;161;162;160;148;164;159;167;144 17:16:33 INFO - PROCESS | 6792 | |13;stanford-crypto-sha256-iterative;75;74;74;69;70;68;71;71;70;69 17:16:33 INFO - PROCESS | 6792 | __end_tp_report 17:16:33 INFO - PROCESS | 6792 | __start_cc_report 17:16:33 INFO - PROCESS | 6792 | _x_x_mozilla_cycle_collect,849 17:16:33 INFO - PROCESS | 6792 | __end_cc_report 17:16:33 INFO - PROCESS | 6792 | __startTimestamp1457313393317__endTimestamp 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | ------- Summary: start ------- 17:16:33 INFO - PROCESS | 6792 | Number of tests: 14 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:4.82 (4.3%) stddev-sans-first:5.09 17:16:33 INFO - PROCESS | 6792 | Values: 114.0 106.0 110.0 112.0 113.0 124.0 111.0 111.0 117.0 111.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:156.00 stddev:17.92 (11.5%) stddev-sans-first:18.64 17:16:33 INFO - PROCESS | 6792 | Values: 159.0 134.0 158.0 173.0 129.0 154.0 153.0 129.0 174.0 128.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:3.06 (1.9%) stddev-sans-first:3.24 17:16:33 INFO - PROCESS | 6792 | Values: 163.0 162.0 161.0 164.0 163.0 160.0 164.0 171.0 164.0 161.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.50 stddev:27.11 (36.4%) stddev-sans-first:28.57 17:16:33 INFO - PROCESS | 6792 | Values: 74.0 73.0 73.0 76.0 74.0 76.0 75.0 73.0 160.0 75.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:94.00 stddev:25.12 (26.7%) stddev-sans-first:25.88 17:16:33 INFO - PROCESS | 6792 | Values: 93.0 96.0 147.0 94.0 94.0 95.0 152.0 94.0 95.0 139.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 17:16:33 INFO - PROCESS | 6792 | Values: 117.0 117.0 118.0 117.0 118.0 116.0 117.0 118.0 117.0 119.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:16:33 INFO - PROCESS | 6792 | Values: 147.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 149.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:16:33 INFO - PROCESS | 6792 | Values: 97.0 96.0 97.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:1.35 (2.3%) stddev-sans-first:1.41 17:16:33 INFO - PROCESS | 6792 | Values: 59.0 57.0 60.0 58.0 61.0 59.0 58.0 58.0 57.0 57.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:16:33 INFO - PROCESS | 6792 | Values: 67.0 69.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:4.03 (4.6%) stddev-sans-first:4.06 17:16:33 INFO - PROCESS | 6792 | Values: 90.0 91.0 91.0 84.0 92.0 83.0 83.0 82.0 84.0 84.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:119.50 stddev:5.09 (4.3%) stddev-sans-first:4.69 17:16:33 INFO - PROCESS | 6792 | Values: 128.0 118.0 117.0 118.0 120.0 119.0 132.0 118.0 121.0 117.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:161.00 stddev:7.81 (4.8%) stddev-sans-first:7.50 17:16:33 INFO - PROCESS | 6792 | Values: 148.0 161.0 161.0 162.0 160.0 148.0 164.0 159.0 167.0 144.0 17:16:33 INFO - PROCESS | 6792 | 17:16:33 INFO - PROCESS | 6792 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:2.42 (3.4%) stddev-sans-first:2.12 17:16:33 INFO - PROCESS | 6792 | Values: 75.0 74.0 74.0 69.0 70.0 68.0 71.0 71.0 70.0 69.0 17:16:33 INFO - PROCESS | 6792 | -------- Summary: end -------- 17:16:33 INFO - PROCESS | 6792 | 17:16:34 INFO - TEST-INFO | 6792: exit 0 17:16:34 INFO - TEST-OK | kraken | took 61324ms 17:16:34 INFO - SUITE-END | took 1173s 17:16:34 INFO - Completed test suite (00:19:33) 17:16:34 INFO - javascript benchmark 17:16:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3160.399524090423, 3214.6303175134867, 3224.1294850390395, 3248.5614442050314, 3276.311974485358, 5170.560502357304, 5285.18079697647, 5286.920696189551, 5289.391719952207, 5364.946350536494, 5286.867828304285, 5291.259223708684, 5293.841184764454, 5378.8924221515645, 5383.353997520293, 4819.662623616348, 4863.173260545698, 4902.754862256891, 4902.852914412573, 4988.176950803113, 4810.11012962603, 4932.087563800708, 4969.776360063788, 4975.303457515933, 4976.253561965698, 4758.976205118952, 4853.39332583427, 4886.096072226632, 4891.046245982035, 4914.066327397801, 4829.782659780319, 4857.61139108874, 4874.902501949941, 4894.681845680019, 4927.433345165316, 4846.369971903665, 4853.514648535118, 4862.343583616202, 4862.513748625144, 4878.8292409765845, 5028.094942910275, 5088.949110508885, 5100.260462232993, 5181.559567436772, 5221.973890130525, 5645.576581756343, 5712.885742285131, 5727.684977326246, 5755.194272801811, 5757.913631295534, 5622.184783206453, 5776.566757493205, 5784.8843023139725, 5792.507636850873, 5813.6221145625395, 5338.332708411449, 5361.678299302093, 5386.434424385461, 5386.649867758583, 5440.265564148829, 5821.621594596338, 5852.063669812895, 5854.970725146347, 5861.472467477947, 5871.853203669857, 5450.591205659592, 5561.805336813192, 5616.831495055155, 5617.0, 5626.915596266059, 5637.661740295595, 5650.406707295757, 5653.9151912721345, 5656.43435656431, 5704.771809127671, 5552.5280351169795, 5622.269105016322, 5631.971840140855, 5654.802081927113, 5685.829425117253, 5537.307836520435, 5666.716664166775, 5690.2033715279895, 5715.114157305624, 5740.856478588069, 4308.439902812677, 4353.194658988097, 4362.302031674917, 4369.759663218553, 4373.387725718402, 3902.6097390261316, 3908.0, 3921.0785465415606, 3930.2139572085125, 3939.7045221607923, 5307.787688492494, 5417.349918009785, 5461.672299661954, 5490.121580547093, 5493.2034854945805, 5716.685582292931, 5747.626404283792, 5750.137479378127, 5753.539716822645, 5766.855828604318, 5412.296401467784, 5449.836504904859, 5466.371367292732, 5471.343438787291, 5473.2063850742215, 4770.427548694179, 4820.25286080658, 4858.975705121452, 4889.951100489021, 4903.5586797188425, 6001.459868611846, 6028.216331876915, 6036.396360364016, 6065.454109130112, 6069.726862291119, 5739.7417116229035, 5746.310442746897, 5749.993751093625, 5750.367459579526, 5788.884222315446, 5860.912086318624, 5988.700564971821, 5995.940040599538, 6018.638881667114, 6093.512518998381, 5572.832815015556, 5584.106542953108, 5599.580031497572, 5604.523615492729, 5627.831165065055, 5643.492085712305, 5652.0, 5695.715214239354, 5698.6010979232715, 5700.486956173964, 5461.9453805461435, 5476.151196564539, 5569.081101618188, 5616.85957851057, 5672.205891175321, 5475.178723191553, 5515.255440515479, 5515.586331025109, 5516.972415137899, 5519.39286678457, 5333.679979201261, 5383.757730902197, 5427.728613569385, 5440.945590544202, 5465.781368745205, 5546.362168350692, 5584.720763961867, 5605.243292155506, 5629.099344105088, 5632.7746890123935, 5368.302120724281, 5451.3458384994055, 5484.753186106715, 5501.944980550144, 5519.337679478488], "unit": "score", "name": "dojo.html", "value": 5264.845301060407}, {"lowerIsBetter": false, "replicates": [522.2010324203968, 535.9249705041295, 547.926029985952, 548.311868604901, 558.3021223470662, 35823.0, 36237.81881090591, 36462.8176859116, 36790.08024799378, 36804.0, 37418.81290593543, 37786.0, 37865.62134378655, 37872.24255514888, 37878.0, 8271.2142346477, 8432.873506897371, 8463.95768021159, 8483.448575842582, 8483.490990540557, 8410.158984101603, 8585.785355366103, 8591.441556298852, 8611.870821937677, 8624.870626940601, 8558.957205213965, 8704.608292626815, 8714.651413943466, 8717.476951382905, 8719.825603487927, 8518.616662250182, 8654.913450865473, 8668.349873759431, 8674.04585495598, 8683.088275731052, 8390.580470976487, 8488.53313067781, 8514.57427128641, 8527.701530446404, 8534.146585341477, 37290.0, 37646.623533764585, 37667.81166094179, 37780.811095944344, 37850.0, 3344.8037857458603, 3609.3503169429755, 3660.3045421369857, 4070.796460177009, 4259.297215959363, 28633.856830715922, 29556.852215738785, 29743.70256297431, 29747.40505189884, 29782.76629252793, 3291.703746662788, 3398.150462384404, 3400.1499625093725, 3467.289205712848, 3487.5989261235027, 269845.0, 273590.0, 274734.999999998, 276026.0, 276157.61921190465, 63495.6825215871, 63609.68195158995, 63694.0, 63873.99999999907, 63895.68052159803, 66183.66908165428, 66715.66642166855, 66728.66635666888, 66730.0, 66809.66595166993, 14490.492832750802, 14701.632459188391, 14765.852341476448, 14773.0, 15292.311845966735, 11542.422878856192, 11657.59198428068, 11677.824832627517, 11696.298222106701, 11752.23610465334, 20572.485687857923, 20601.587968240852, 20807.68788468174, 20878.0, 21099.261525846523, 7827.412944029106, 8086.959565202254, 8141.592920353959, 8220.972378452694, 8317.792055198548, 968.4528241543505, 979.9216062714966, 986.7039888033561, 1020.1125021231428, 1125.8986691197667, 28780.0, 28965.710342896302, 29069.854650727033, 29091.27271818179, 29265.85367073151, 1080.529969463286, 1158.5655379232787, 1179.6402097360217, 1195.5755706723987, 1199.4122879789015, 15108.697826043417, 15118.697626047637, 15294.694106117815, 15328.770068448983, 15345.693086138437, 287387.0, 290101.0, 291732.0, 291767.0, 292138.0, 50599.494005060216, 52038.47961520412, 52085.739571302656, 52212.21681674778, 52263.73868130635, 1334.8932085433141, 1358.9796153057712, 1368.1996032321006, 1371.3965855023757, 1374.6357215337944, 27435.0, 27832.44335113246, 28011.859940700982, 28430.57354139731, 28547.857260713565, 46995.0, 47184.52815471801, 47274.29088563605, 47345.289820652026, 47443.76278118725, 268932.0, 273285.0, 275947.0, 276736.0, 276960.0, 31875.043748687578, 32254.19364515906, 32280.35439291248, 32320.83839580787, 32333.35333293274, 42295.7885210572, 43395.0, 43459.78270108629, 43746.12507749891, 43809.78095109504, 36379.45430818593, 36580.634193658785, 36846.631533685395, 36889.63110368862, 37099.0, 35372.469412958315, 35791.0, 36273.81863090667, 36617.08457288589, 36830.63169368272, 35165.0, 35987.0, 36225.637743622225, 36548.63451365452, 36555.08612284714, 31740.04779856608, 32666.51000235046, 32844.1788955278, 32868.83565582253, 33304.0, 25174.0, 25281.241562753148, 25302.620460693473, 25372.619410709223, 25618.359541011625], "unit": "score", "name": "ext.html", "value": 18431.310526079218}, {"lowerIsBetter": false, "replicates": [345.4127982429869, 349.08887802834613, 359.29578027066947, 360.1015466411303, 368.4197389112147, 16373.345066197353, 16725.0, 17089.31642734292, 17184.742228866577, 17269.30922763091, 16607.584810379718, 16828.495145145636, 16866.409675661354, 17071.14644267788, 17195.14024298786, 5168.173092305232, 5348.545373643245, 5379.488948549882, 5435.891282174364, 5637.379888212294, 5235.188545775411, 5365.409804921455, 5381.273528073699, 5383.057964856154, 5417.241586177938, 5621.4659607337235, 5644.0, 5656.123300888369, 5658.632188907728, 5667.291588551431, 5536.2249285099715, 5622.465865742748, 5626.774929002855, 5629.789595237024, 5638.943610563903, 5475.0418676731415, 5539.25220095286, 5552.0, 5555.611107222496, 5562.4993750562235, 12850.293233872133, 12931.288779117145, 13104.86895131046, 19601.607967840708, 20209.797902021084, 2010.9095090720953, 2059.5571952030236, 2117.46004768783, 2141.239859849762, 2161.448830548216, 9188.44869307837, 9396.859047114298, 9408.153266206005, 9647.469389183592, 9699.321047526675, 1832.890026598395, 1841.1898764543557, 1868.8785228960073, 1880.0693656639914, 1922.6731455652573, 50370.24444633334, 55375.72312138454, 58844.11733823996, 61902.690486547726, 64911.0, 9933.205343572497, 10054.145397641283, 10233.130183934449, 10363.689089327332, 10525.84211236832, 13656.590302290948, 13678.316084195949, 13792.724145517033, 13831.723365532633, 13849.51526696581, 7373.410127189812, 7424.0, 7465.58939258346, 7514.849703005909, 7643.121041080236, 7051.400630946325, 7153.642317884189, 7206.0, 7219.169795473483, 7293.1248250209255, 4507.797149128297, 4536.455625324982, 4589.403377560896, 4615.2384856498975, 4667.649926255544, 1857.5449014991143, 1868.5422071592548, 1873.4847916822982, 1907.3038341005433, 1911.0, 886.7339798060556, 944.9291303152291, 971.2084651009404, 978.6819283732815, 992.3301771304341, 15503.767443488357, 16089.597760055858, 16322.75515867263, 16539.25573349202, 16637.91681041587, 881.9073997230198, 892.2995448572968, 917.0966597901062, 949.4588084791602, 964.9674847912667, 7170.498065135391, 9411.952940235393, 9419.90580094204, 9484.430934143973, 9513.762155946157, 383989.0, 388616.0, 390426.0, 390712.0, 391148.0, 68133.0, 70215.0, 70491.0, 71715.0, 72632.0, 993.3046867192994, 997.7655251016006, 998.6454808543008, 1011.5346940407347, 1013.1489548779061, 14189.432422703389, 14448.927755361156, 14588.0, 14764.704705906037, 14964.476243331432, 31455.37089258248, 32729.18177045593, 33007.174820629676, 33085.50371744474, 33218.16954576058, 45479.31781023354, 45536.0, 45749.31376029429, 45941.31088033749, 46273.0, 7520.661570229462, 7580.241975802375, 7618.200088990798, 7720.266574675621, 7727.0727512696585, 9928.67389424522, 11535.538578456768, 11782.0, 11782.764344713229, 12339.197952133083, 9890.45602491841, 10221.591136354462, 10267.486625668538, 10353.84469232947, 10521.421321827373, 10103.898961010296, 10140.391576505433, 10443.861635969626, 10476.738081548023, 10533.10468610146, 8145.551994640115, 8194.713185038734, 8197.303229225583, 8532.0, 10408.219383546113, 10607.242117049469, 10687.89312106869, 10934.507947142556, 11144.219904606924, 11286.92774186451, 11480.94259528697, 11571.6528504145, 11666.300021998708, 11709.707257318294, 11787.351695656822], "unit": "score", "name": "jquery.html", "value": 8234.865663959368}, {"lowerIsBetter": false, "replicates": [1467.2003757951916, 1473.2412807404185, 1673.3390310827224, 1830.789459212191, 1859.20054376618, 7070.151581810177, 7745.573993430359, 7913.802154946122, 8094.271515563598, 8147.0, 7752.689892404297, 7818.179091195428, 7850.489718168315, 7903.1701671324545, 7914.683412663501, 2246.7079279693658, 2269.137727663494, 2278.906125059972, 2288.9771102289014, 2293.1056887813766, 2315.2012555668266, 2333.5449587330477, 2372.063035101134, 2380.4643955110137, 2382.7617238276207, 2368.3842201027683, 2385.2367242482414, 2397.0, 2415.6497307890345, 2416.6495858100566, 2392.5932591459496, 2401.903923843044, 2402.627592723131, 2420.5521978434044, 2424.0425032112394, 2315.120254303354, 2337.8947947342413, 2344.9564943600103, 2353.7175538935267, 2362.692849929498, 7967.28294453502, 8072.0, 8079.0, 8090.514569125871, 8091.0, 5005.824796132154, 5055.3933527976515, 5089.185730283174, 5128.640995130342, 5133.974330128362, 3293.4730443128983, 3322.5846769153854, 3361.126107212118, 3361.6134144573443, 3397.0997685613333, 1101.6034227678028, 1109.4563663804759, 1113.8050841102856, 1116.1851848150895, 1117.793208256475, 10961.83557246642, 11009.889901100967, 11020.779584408347, 11067.169962252783, 11077.058450031756, 4581.679282450264, 4585.403897493305, 4637.930431043537, 4665.323528088408, 4677.111348843709, 9570.186534144537, 9574.281928855364, 9575.707279517315, 9580.13778759915, 9596.280278979104, 5020.59835213182, 5045.571126454292, 5046.798128074909, 5053.620978426633, 5078.5937125029905, 4030.5163380394542, 4327.112941846914, 4361.781910904442, 4520.254158063883, 4523.909521809545, 3873.0, 3905.3165696003084, 3922.686185105185, 3956.4658771065538, 3962.722609417313, 1232.975340493185, 1238.9008879289636, 1251.217988757027, 1261.8611952685196, 1262.211118051218, 1310.967225819362, 1317.466426097432, 1320.7886738121854, 1336.2717319061135, 1347.158026233604, 7160.892586611205, 7207.783766487014, 7269.454790890704, 7308.817279568053, 7328.083989501312, 510.57112025898425, 516.4731973387125, 520.5081198267601, 520.565327951165, 525.385299199937, 5308.362996440452, 5308.973455132699, 5348.304720386403, 5356.276902618097, 5379.65032272901, 9291.117343852324, 9454.669086582075, 9466.337356384987, 9468.479233642216, 9593.952030239943, 9428.90571094294, 9431.151196392357, 9436.245100391952, 9445.0, 9453.101955314234, 7242.6378681065735, 7446.218147094585, 7468.253174682488, 7533.660985255677, 7567.432442566829, 7282.781516554512, 7306.853862922605, 7339.559626422431, 7340.70637174507, 7405.407567394488, 8517.105703901248, 8626.91373086261, 8757.211850933192, 8759.12408759119, 8910.955445222991, 8938.41900276506, 8970.820583588162, 9038.728838134866, 9044.592993315448, 9192.448453092567, 6321.652309123042, 6707.865842683216, 6852.314768523108, 7027.543209691354, 7126.216116227107, 7549.0941087069905, 7588.354989825927, 7593.468457207942, 7596.392288616787, 7599.4680372373405, 6734.4612431004425, 6891.552049116792, 6915.377616014583, 6960.79117626472, 7027.367536921702, 6669.2997235289595, 6728.596284222962, 6731.394174524316, 6861.245263021164, 6909.998050282781, 6773.424258938046, 6840.0, 6840.657967101525, 7007.194172670208, 7204.639768011473, 6425.935740642533, 6447.387498187664, 6453.903191452038, 6470.773522926675, 6482.611043337415, 6614.404703576702, 6696.83257918556, 6707.832304192434, 6720.1599800025, 6723.394894459522], "unit": "score", "name": "mootools.html", "value": 4537.01599307822}, {"lowerIsBetter": false, "replicates": [334.585114458072, 345.29904294282613, 351.1799947123467, 357.44417430894947, 358.1744079895839, 6168.907466388007, 6225.035119556464, 6233.189685340911, 6252.124702541642, 6252.593581417211, 6180.289266734327, 6185.257769067707, 6214.502839772818, 6220.533459990496, 6238.095476155955, 4554.590086892179, 4650.395448591678, 4770.833020844271, 4772.355731976173, 4784.354112194844, 4727.810887564493, 4736.97631511842, 4747.1692453820615, 4756.548127927858, 4764.047190561884, 4718.693284936468, 4718.97640511797, 4728.66899317048, 4728.716277023373, 4737.7631118444115, 4713.835015774432, 4724.811007559693, 4733.502982186872, 4781.0676918001, 4789.640776941744, 4185.602367775056, 4203.91592168155, 4208.305629571117, 4216.789160541991, 4228.4080228768, 5834.620749651259, 5938.6436813791315, 5942.405759424067, 5952.255968003999, 5954.2259506264345, 5527.50252477279, 5550.084236101038, 5568.582356323252, 5578.693171875545, 5578.9163162552595, 6550.312217217172, 6561.573497722633, 6570.375814297634, 6589.341065893373, 6594.736210551572, 4670.159371313162, 4673.719576825368, 4673.859784206479, 4678.087772884289, 4681.625469962395, 6810.727570897158, 6847.623380714109, 6877.724891004354, 6905.37851593359, 6910.308969103049, 4411.139827733561, 4587.03672228829, 4761.309610106515, 4781.880452988703, 4794.208955522369, 4624.583787459078, 4633.957359594065, 4656.650751193674, 4659.347691323217, 4682.0, 5406.08096623575, 5424.538914192338, 5426.647267927572, 5428.077226871442, 5442.292501974797, 6584.176977877765, 6597.274299827015, 6627.668616569249, 6629.1382120325015, 6645.501587380966, 1617.5713435939485, 1638.5412084616326, 1640.442249635106, 1642.3020216407979, 1655.9236496277515, 1070.5610699613121, 1090.7491277006334, 1096.780643871229, 1104.4753741972659, 1122.0630773304383, 6355.841103972438, 6361.61830290184, 6379.979203327445, 6382.808515744442, 6392.808215753535, 6747.156605424322, 6799.354061364163, 6806.489513286424, 6816.522843401013, 6829.146356705412, 6280.968595157086, 6435.22777266731, 6459.224893012869, 6459.61242325462, 6466.708998095097, 3688.0, 3704.7036237100965, 3711.851525938986, 3715.3498137825773, 3723.236736469017, 7299.8540029200185, 7331.193568707438, 7348.889766653505, 7364.410847132217, 7365.668544915492, 7032.964835175791, 7051.224365319811, 7061.293870613001, 7070.222275549685, 7083.822904427328, 7065.081539399948, 7316.634168291458, 7342.375898048619, 7342.449316301192, 7354.117505899327, 6808.148981377328, 6857.2114206866845, 6864.38220560152, 6865.073215115895, 6876.69054892521, 6800.31996800316, 6804.4896632753735, 6833.214180369321, 6836.692348844414, 6836.794896153124, 7261.164966028974, 7296.270372962661, 7337.339639432476, 7343.44924130703, 7348.1182258129365, 4497.527759585197, 4669.696469729457, 4678.041001594597, 4686.320483529801, 4694.201985662514, 6875.209350924708, 6881.243063262937, 6890.827729306808, 6902.965485172542, 6911.0, 6629.43649789754, 6656.633885136364, 6656.800295991128, 6667.533272670867, 6675.6995935184, 6672.799816005528, 6674.26583075871, 6681.933180668326, 6688.063671086149, 6694.0, 6391.744330226739, 6565.310642382481, 6572.474202063919, 6577.704003319766, 6586.637734924433, 6696.0, 6726.6972986216715, 6727.192736871607, 6732.495062870402, 6739.123913891162, 6484.319146489551, 6558.147440832661, 6559.983202603604, 6570.310117437601, 6573.04690819838], "unit": "score", "name": "prototype.html", "value": 5006.320978267745}, {"lowerIsBetter": false, "replicates": [671.8118926700524, 678.9932100678993, 717.7057406463348, 720.4632548751181, 721.58508857407, 12497.312647804367, 13180.604581862548, 13291.268980206085, 13569.52506662267, 14845.109293442401, 14106.788398174036, 14171.78742318866, 14242.501512447066, 14248.28758562073, 14298.499552515665, 835.8537255980209, 839.1314988986401, 842.4103127810527, 843.9240468357847, 846.187659846545, 844.3245403677065, 844.7423535821572, 846.2341580869323, 847.0682249525504, 848.8896443462341, 891.242443922667, 899.7570655922897, 900.7703035725914, 902.2105657549644, 902.463034494478, 882.4396508217264, 883.337496877342, 886.601029536711, 889.5152142082613, 890.6214858685065, 653.5425202358368, 656.0159760359461, 656.2190992718649, 656.3370995294787, 657.8190997475684, 13294.135881167693, 13389.531366402129, 13634.522791702342, 14236.074655147382, 14256.928715356356, 12933.641967593456, 13173.407196676173, 13273.53542626013, 13492.662683432993, 13787.103838250481, 10557.736056598647, 10594.62918797846, 10733.62432314873, 10738.516766745515, 10824.40465774382, 3597.8560857565667, 3645.8359373827975, 3661.3226553087766, 3666.468362087509, 3791.469194312798, 46309.30536041962, 46361.536384636056, 47148.05703885938, 48131.75934120342, 48598.7570062151, 10591.523381447852, 10720.142388608892, 10733.355998640107, 10740.194485413625, 10830.241883068267, 18620.06899655012, 18708.906455467637, 18716.344927927457, 18721.344752933855, 18791.15439805212, 7742.7677169685, 7886.290233878864, 7933.920660793318, 7964.0, 7979.20207979209, 4321.719088259253, 4518.012074687127, 4544.522825103382, 4554.248548989446, 4583.427071616048, 3212.245122396235, 3246.269589342426, 3247.1395080303737, 3249.52881832133, 3252.447083995726, 609.326694003129, 613.4846728747873, 615.806021103351, 617.9474744646666, 623.2147494157394, 645.6836150286326, 645.7107770317078, 648.5427773419727, 662.2053535757015, 663.3598577372859, 8523.786905327417, 8636.69771558005, 8638.524881131472, 8937.329700272505, 8953.418027828171, 640.679660169915, 645.515863102673, 660.2110477978865, 660.3231687520234, 669.0, 3942.2312649033165, 4085.775282359439, 4086.1010577672864, 4106.650934670527, 4252.213340532012, 54151.0, 56715.0, 56769.7161514198, 57048.0, 57365.0, 47956.5204347959, 48199.75900120477, 48415.273770893466, 49733.0, 49924.50075499271, 44916.3262551062, 45203.0, 45809.31286030712, 45811.083778324246, 46164.0, 7974.362051035787, 8189.181081892001, 8201.26188643025, 8223.09545949957, 8253.504789712637, 34491.48262776111, 34962.9511114667, 35321.646783532866, 35975.28049439049, 37088.81455592705, 40659.59340406676, 43143.0, 44245.778771105935, 44259.0, 44968.77515612401, 9980.201583873128, 10035.749106272402, 10562.207834412297, 10693.839592405964, 10832.350058996486, 11225.66323010311, 11387.601433949772, 11463.197576169589, 11591.050806873884, 11600.187986841178, 9963.153131983572, 10054.748631284276, 10098.747531311776, 10118.392896426238, 10309.165144300252, 10733.463326833784, 10794.136469082612, 11233.662990109982, 11457.427128643702, 11476.540938362372, 9701.320907536687, 9725.0, 9861.457619830979, 10831.350118992885, 10841.349519028883, 9182.770430739285, 9289.800070815429, 9357.85963210566, 9463.697352229114, 9699.127078562964, 8545.487270763773, 8724.384020413056, 8938.553072346227, 9230.261579073793, 9456.716298511055], "unit": "score", "name": "yui.html", "value": 6325.086186298936}], "name": "dromaeo_css", "value": 6971.587095218689}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 110.0, 112.0, 113.0, 124.0, 111.0, 111.0, 117.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [159.0, 134.0, 158.0, 173.0, 129.0, 154.0, 153.0, 129.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 164.0, 163.0, 160.0, 164.0, 171.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 76.0, 74.0, 76.0, 75.0, 73.0, 160.0, 75.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 147.0, 94.0, 94.0, 95.0, 152.0, 94.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 116.0, 117.0, 118.0, 117.0, 119.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 60.0, 58.0, 61.0, 59.0, 58.0, 58.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 91.0, 84.0, 92.0, 83.0, 83.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [128.0, 118.0, 117.0, 118.0, 120.0, 119.0, 132.0, 118.0, 121.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [148.0, 161.0, 161.0, 162.0, 160.0, 148.0, 164.0, 159.0, 167.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 157.4}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 69.0, 70.0, 68.0, 71.0, 71.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1541.1000000000001}]} 17:16:34 INFO - Return code: 0 17:16:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:16:34 ERROR - # TBPL SUCCESS # 17:16:34 INFO - Running post-action listener: _resource_record_post_action 17:16:34 INFO - Running post-run listener: _resource_record_post_run 17:16:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 499712; Write bytes: 293900288; Read time: 60; Write time: 267892 17:16:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5169152; Read time: 0; Write time: 300 17:16:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 499712; Write bytes: 288731136; Read time: 60; Write time: 267592 17:16:35 INFO - Running post-run listener: _upload_blobber_files 17:16:35 INFO - Blob upload gear active. 17:16:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:16:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:16:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:16:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:16:36 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:36 INFO - (blobuploader) - INFO - Done attempting. 17:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:37 INFO - (blobuploader) - INFO - Done attempting. 17:16:37 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:37 INFO - Return code: 0 17:16:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:16:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53f06c4ac8ce3528cbd9b1dd1070aba9d9f9efbc014303cf3ff7f6d0db8ce789db1e6993cd39fa9e7af2e909e1037747f78eddb6aac1f53be12cb2cc97f3a936", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be462d9944e68b656859cbba63d1a103ff60335c908092337cf0b772a3804d5628e84d816347e45bca464ffc71921451cdd878f533cffd17ec707e3e923baa3"} 17:16:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:16:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:16:37 INFO - Contents: 17:16:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53f06c4ac8ce3528cbd9b1dd1070aba9d9f9efbc014303cf3ff7f6d0db8ce789db1e6993cd39fa9e7af2e909e1037747f78eddb6aac1f53be12cb2cc97f3a936", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be462d9944e68b656859cbba63d1a103ff60335c908092337cf0b772a3804d5628e84d816347e45bca464ffc71921451cdd878f533cffd17ec707e3e923baa3"} 17:16:37 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:37 INFO - Copying logs to upload dir... 17:16:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:16:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.283319 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-06 17:16:37.584341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 17:16:37.587668) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53f06c4ac8ce3528cbd9b1dd1070aba9d9f9efbc014303cf3ff7f6d0db8ce789db1e6993cd39fa9e7af2e909e1037747f78eddb6aac1f53be12cb2cc97f3a936", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be462d9944e68b656859cbba63d1a103ff60335c908092337cf0b772a3804d5628e84d816347e45bca464ffc71921451cdd878f533cffd17ec707e3e923baa3"} build_url:https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/a1Q3QmMuSBCKRpIJgA03ZQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53f06c4ac8ce3528cbd9b1dd1070aba9d9f9efbc014303cf3ff7f6d0db8ce789db1e6993cd39fa9e7af2e909e1037747f78eddb6aac1f53be12cb2cc97f3a936", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6be462d9944e68b656859cbba63d1a103ff60335c908092337cf0b772a3804d5628e84d816347e45bca464ffc71921451cdd878f533cffd17ec707e3e923baa3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-06 17:16:37.617557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 17:16:37.618360) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1457309807.766123-1709101436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-06 17:16:37.698265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 17:16:37.699036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-06 17:16:37.699791) ========= ========= Total master_lag: 0.31 =========