builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1457636670.4 results: success (0) buildid: 20160310083118 builduid: 4d29b406d83b4b4cb57913dc0896812b revision: 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.395561) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.395973) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.396275) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006430 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.434999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.435371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.528448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.528712) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.601116) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.601437) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.601826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.602147) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 11:04:30-- 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% 33.4M=0s 2016-03-10 11:04:30 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.708465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.708754) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021383 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:30.759870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 11:04:30.760177) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 --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 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 --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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 11:04:30,962 truncating revision to first 12 chars 2016-03-10 11:04:30,962 Setting DEBUG logging. 2016-03-10 11:04:30,962 attempt 1/10 2016-03-10 11:04:30,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/36bd53d339e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 11:04:32,241 unpacking tar archive at: fx-team-36bd53d339e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.599127 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 11:04:32.373520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:32.373860) ========= echo 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'36bd53d339e68ef345ae92dbacfa749c67dcc2d0'] 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 program finished with exit code 0 elapsedTime=0.004697 script_repo_revision: '36bd53d339e68ef345ae92dbacfa749c67dcc2d0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:32.424439) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:32.424757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 11:04:32.435034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-10 11:04:32.435382) ========= /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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:32 INFO - MultiFileLogger online at 20160310 11:04:32 in /builds/slave/test-pgo 11:04:32 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 11:04:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:04:32 INFO - {'append_to_log': False, 11:04:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:04:32 INFO - 'blob_upload_branch': 'Fx-Team', 11:04:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:04:32 INFO - 'branch': 'Fx-Team', 11:04:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:32 INFO - 'config_files': ('talos/linux_config.py',), 11:04:32 INFO - 'default_actions': ('clobber', 11:04:32 INFO - 'read-buildbot-config', 11:04:32 INFO - 'download-and-extract', 11:04:32 INFO - 'populate-webroot', 11:04:32 INFO - 'create-virtualenv', 11:04:32 INFO - 'install', 11:04:32 INFO - 'run-tests'), 11:04:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:32 INFO - 'download_minidump_stackwalk': True, 11:04:32 INFO - 'download_symbols': 'ondemand', 11:04:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:32 INFO - 'installer_path': 'installer.exe', 11:04:32 INFO - 'log_level': 'info', 11:04:32 INFO - 'log_name': 'talos', 11:04:32 INFO - 'log_to_console': True, 11:04:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:32 INFO - 'opt_config_files': (), 11:04:32 INFO - 'pip_index': False, 11:04:32 INFO - 'sps_profile': False, 11:04:32 INFO - 'sps_profile_interval': 0, 11:04:32 INFO - 'suite': 'dromaeojs-e10s', 11:04:32 INFO - 'system_bits': '32', 11:04:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:32 INFO - 'title': 'talos-linux64-ix-020', 11:04:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:32 INFO - 'use_talos_json': True, 11:04:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:04:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:32 INFO - 'work_dir': 'build'} 11:04:32 INFO - ##### 11:04:32 INFO - ##### Running clobber step. 11:04:32 INFO - ##### 11:04:32 INFO - Running pre-action listener: _resource_record_pre_action 11:04:32 INFO - Running main action method: clobber 11:04:32 INFO - rmtree: /builds/slave/test-pgo/build 11:04:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:04:33 INFO - Running post-action listener: _resource_record_post_action 11:04:33 INFO - ##### 11:04:33 INFO - ##### Running read-buildbot-config step. 11:04:33 INFO - ##### 11:04:33 INFO - Running pre-action listener: _resource_record_pre_action 11:04:33 INFO - Running main action method: read_buildbot_config 11:04:33 INFO - Using buildbot properties: 11:04:33 INFO - { 11:04:33 INFO - "project": "", 11:04:33 INFO - "product": "firefox", 11:04:33 INFO - "script_repo_revision": "production", 11:04:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:04:33 INFO - "repository": "", 11:04:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:04:33 INFO - "buildid": "20160310083118", 11:04:33 INFO - "pgo_build": "True", 11:04:33 INFO - "basedir": "/builds/slave/test-pgo", 11:04:33 INFO - "buildnumber": 557, 11:04:33 INFO - "slavename": "talos-linux64-ix-020", 11:04:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:04:33 INFO - "platform": "ubuntu64_hw", 11:04:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:04:33 INFO - "branch": "fx-team", 11:04:33 INFO - "repo_path": "integration/fx-team", 11:04:33 INFO - "revision": "36bd53d339e68ef345ae92dbacfa749c67dcc2d0", 11:04:33 INFO - "stage_platform": "linux64-pgo", 11:04:33 INFO - "builduid": "4d29b406d83b4b4cb57913dc0896812b", 11:04:33 INFO - "slavebuilddir": "test" 11:04:33 INFO - } 11:04:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:04:33 INFO - Running post-action listener: _resource_record_post_action 11:04:33 INFO - ##### 11:04:33 INFO - ##### Running download-and-extract step. 11:04:33 INFO - ##### 11:04:33 INFO - Running pre-action listener: _resource_record_pre_action 11:04:33 INFO - Running main action method: download_and_extract 11:04:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:04: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')]} 11:04:33 INFO - https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:04:35 INFO - Downloaded 1361 bytes. 11:04:35 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:04:35 INFO - Using the following test package requirements: 11:04:35 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:35 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:04:35 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:04:35 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'jsshell-linux-x86_64.zip'], 11:04:35 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:04:35 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:04:35 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:04:35 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:04:35 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:04:35 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:04:35 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:04:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:04:35 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')]} 11:04:35 INFO - https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:38 INFO - Downloaded 23406562 bytes. 11:04:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:04:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:04:39 INFO - Return code: 0 11:04:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:04:39 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')]} 11:04:39 INFO - https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:44 INFO - Downloaded 23406562 bytes. 11:04:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:04:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:04:45 INFO - Return code: 0 11:04:45 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')]} 11:04:45 INFO - https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:04:46 INFO - Downloaded 10845161 bytes. 11:04:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:04:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:04:46 INFO - Return code: 0 11:04:46 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')]} 11:04:46 INFO - https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:04:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:04:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:04:48 INFO - Downloaded 56229569 bytes. 11:04:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:04:48 INFO - mkdir: /builds/slave/test-pgo/properties 11:04:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:04:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:04:48 INFO - Contents: 11:04:48 INFO - build_url:https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:04:49 INFO - Running post-action listener: _resource_record_post_action 11:04:49 INFO - Running post-action listener: set_extra_try_arguments 11:04:49 INFO - ##### 11:04:49 INFO - ##### Running populate-webroot step. 11:04:49 INFO - ##### 11:04:49 INFO - Running pre-action listener: _resource_record_pre_action 11:04:49 INFO - Running main action method: populate_webroot 11:04:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:04:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:04:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:04:49 INFO - '--tppagecycles', 11:04:49 INFO - '7'], 11:04:49 INFO - 'tests': ['tsvgm']}}, 11:04:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:04:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:04:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:04:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:04:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:04:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'tests': ['damp', 'tps']}, 11:04:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['damp', 'tps']}, 11:04:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:04:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:04:49 INFO - 'other': {'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'other_l64': {'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'other_nol64': {'tests': ['a11yr', 11:04:49 INFO - 'ts_paint', 11:04:49 INFO - 'tpaint', 11:04:49 INFO - 'sessionrestore', 11:04:49 INFO - 'sessionrestore_no_auto_restore', 11:04:49 INFO - 'tabpaint']}, 11:04:49 INFO - 'svgr': {'tests': ['tsvgx', 11:04:49 INFO - 'tsvgr_opacity', 11:04:49 INFO - 'tart', 11:04:49 INFO - 'tscrollx', 11:04:49 INFO - 'cart']}, 11:04:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['tsvgx', 11:04:49 INFO - 'tsvgr_opacity', 11:04:49 INFO - 'tart', 11:04:49 INFO - 'tscrollx', 11:04:49 INFO - 'cart']}, 11:04:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'tests': ['tp5o']}, 11:04:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'talos_options': ['--e10s'], 11:04:49 INFO - 'tests': ['tp5o']}, 11:04:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'talos_options': ['--xperf_path', 11:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:49 INFO - 'tests': ['tp5n']}, 11:04:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:04:49 INFO - 'talos_options': ['--e10s', 11:04:49 INFO - '--xperf_path', 11:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:04:49 INFO - 'tests': ['tp5n']}}, 11:04:49 INFO - 'talos.zip': {'path': '', 11:04:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:04:49 INFO - Running post-action listener: _resource_record_post_action 11:04:49 INFO - ##### 11:04:49 INFO - ##### Running create-virtualenv step. 11:04:49 INFO - ##### 11:04:49 INFO - Running pre-action listener: _resource_record_pre_action 11:04:49 INFO - Running main action method: create_virtualenv 11:04:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:04:49 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 11:04:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:04:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:04:49 INFO - Using real prefix '/usr' 11:04:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:04:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:04:52 INFO - Installing pip.................done. 11:04:52 INFO - Return code: 0 11:04:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:04:52 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')]} 11:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:52 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')]} 11:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:52 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:04:52 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 11:04:52 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 11:04:52 INFO - Using env: {'DISPLAY': ':0', 11:04:52 INFO - 'HOME': '/home/cltbld', 11:04:52 INFO - 'LANG': 'en_US.UTF-8', 11:04:52 INFO - 'LANGUAGE': 'en_US:en', 11:04:52 INFO - 'LOGNAME': 'cltbld', 11:04:52 INFO - 'MAIL': '/var/mail/cltbld', 11:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:52 INFO - 'MOZ_NO_REMOTE': '1', 11:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:52 INFO - 'NO_EM_RESTART': '1', 11:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:04:52 INFO - 'SHELL': '/bin/bash', 11:04:52 INFO - 'SHLVL': '1', 11:04:52 INFO - 'TERM': 'linux', 11:04:52 INFO - 'TMOUT': '86400', 11:04:52 INFO - 'USER': 'cltbld', 11:04:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:52 INFO - '_': '/tools/buildbot/bin/python'} 11:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:52 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 11:04:52 INFO - Cleaning up... 11:04:52 INFO - Return code: 0 11:04:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:04:52 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')]} 11:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:52 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')]} 11:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:52 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:04:52 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 11:04:52 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 11:04:52 INFO - Using env: {'DISPLAY': ':0', 11:04:52 INFO - 'HOME': '/home/cltbld', 11:04:52 INFO - 'LANG': 'en_US.UTF-8', 11:04:52 INFO - 'LANGUAGE': 'en_US:en', 11:04:52 INFO - 'LOGNAME': 'cltbld', 11:04:52 INFO - 'MAIL': '/var/mail/cltbld', 11:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:52 INFO - 'MOZ_NO_REMOTE': '1', 11:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:52 INFO - 'NO_EM_RESTART': '1', 11:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:04:52 INFO - 'SHELL': '/bin/bash', 11:04:52 INFO - 'SHLVL': '1', 11:04:52 INFO - 'TERM': 'linux', 11:04:52 INFO - 'TMOUT': '86400', 11:04:52 INFO - 'USER': 'cltbld', 11:04:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:52 INFO - '_': '/tools/buildbot/bin/python'} 11:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:52 INFO - Downloading/unpacking psutil>=0.7.1 11:04:52 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 11:04:52 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 11:04:52 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 11:04:52 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 11:04:52 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 11:04:52 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 11:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:55 INFO - Installing collected packages: psutil 11:04:55 INFO - Running setup.py install for psutil 11:04:55 INFO - building 'psutil._psutil_linux' extension 11:04:55 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 11:04:55 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 11:04:55 INFO - building 'psutil._psutil_posix' extension 11:04:55 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 11:04:55 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 11:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:04:55 INFO - Successfully installed psutil 11:04:55 INFO - Cleaning up... 11:04:55 INFO - Return code: 0 11:04:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:04:55 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')]} 11:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:55 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')]} 11:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:55 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:04:55 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 11:04:55 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 11:04:55 INFO - Using env: {'DISPLAY': ':0', 11:04:55 INFO - 'HOME': '/home/cltbld', 11:04:55 INFO - 'LANG': 'en_US.UTF-8', 11:04:55 INFO - 'LANGUAGE': 'en_US:en', 11:04:55 INFO - 'LOGNAME': 'cltbld', 11:04:55 INFO - 'MAIL': '/var/mail/cltbld', 11:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:55 INFO - 'MOZ_NO_REMOTE': '1', 11:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:55 INFO - 'NO_EM_RESTART': '1', 11:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 11:04:55 INFO - 'SHELL': '/bin/bash', 11:04:55 INFO - 'SHLVL': '1', 11:04:55 INFO - 'TERM': 'linux', 11:04:55 INFO - 'TMOUT': '86400', 11:04:55 INFO - 'USER': 'cltbld', 11:04:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:55 INFO - '_': '/tools/buildbot/bin/python'} 11:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:04:55 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 11:04:55 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 11:04:55 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 11:04:55 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 11:04:55 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 11:04:55 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 11:04:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:04:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:04:57 INFO - Installing collected packages: mozsystemmonitor 11:04:57 INFO - Running setup.py install for mozsystemmonitor 11:04:57 INFO - Successfully installed mozsystemmonitor 11:04:57 INFO - Cleaning up... 11:04:57 INFO - Return code: 0 11:04:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:04:57 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')]} 11:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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')]} 11:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:04:57 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:04:57 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 11:04:57 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 11:04:57 INFO - Using env: {'DISPLAY': ':0', 11:04:57 INFO - 'HOME': '/home/cltbld', 11:04:57 INFO - 'LANG': 'en_US.UTF-8', 11:04:57 INFO - 'LANGUAGE': 'en_US:en', 11:04:57 INFO - 'LOGNAME': 'cltbld', 11:04:57 INFO - 'MAIL': '/var/mail/cltbld', 11:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:04:57 INFO - 'MOZ_NO_REMOTE': '1', 11:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:04:57 INFO - 'NO_EM_RESTART': '1', 11:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:04:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:04:57 INFO - 'SHELL': '/bin/bash', 11:04:57 INFO - 'SHLVL': '1', 11:04:57 INFO - 'TERM': 'linux', 11:04:57 INFO - 'TMOUT': '86400', 11:04:57 INFO - 'USER': 'cltbld', 11:04:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:04:57 INFO - '_': '/tools/buildbot/bin/python'} 11:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:04:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:57 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 11:04:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:04:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:04:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:04:59 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 11:05:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:05:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:00 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 11:05:00 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 11:05:00 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 11:05:00 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 11:05:00 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 11:05:00 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 11:05:00 INFO - Downloading docopt-0.6.1.tar.gz 11:05:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:00 INFO - Running setup.py install for blobuploader 11:05:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:05:00 INFO - Running setup.py install for requests 11:05:01 INFO - Running setup.py install for docopt 11:05:01 INFO - Successfully installed blobuploader requests docopt 11:05:01 INFO - Cleaning up... 11:05:01 INFO - Return code: 0 11:05:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:05:01 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')]} 11:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:01 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')]} 11:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:01 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:05:01 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 11:05:01 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 11:05:01 INFO - Using env: {'DISPLAY': ':0', 11:05:01 INFO - 'HOME': '/home/cltbld', 11:05:01 INFO - 'LANG': 'en_US.UTF-8', 11:05:01 INFO - 'LANGUAGE': 'en_US:en', 11:05:01 INFO - 'LOGNAME': 'cltbld', 11:05:01 INFO - 'MAIL': '/var/mail/cltbld', 11:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:01 INFO - 'MOZ_NO_REMOTE': '1', 11:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:01 INFO - 'NO_EM_RESTART': '1', 11:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:01 INFO - 'SHELL': '/bin/bash', 11:05:01 INFO - 'SHLVL': '1', 11:05:01 INFO - 'TERM': 'linux', 11:05:01 INFO - 'TMOUT': '86400', 11:05:01 INFO - 'USER': 'cltbld', 11:05:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:01 INFO - '_': '/tools/buildbot/bin/python'} 11:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:01 INFO - Running setup.py (path:/tmp/pip-jUUwLI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:01 INFO - Running setup.py (path:/tmp/pip-597PMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:01 INFO - Running setup.py (path:/tmp/pip-o3pCLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:01 INFO - Running setup.py (path:/tmp/pip-qgWQkO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:01 INFO - Running setup.py (path:/tmp/pip-fP5dFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:01 INFO - Running setup.py (path:/tmp/pip-FCgysg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:01 INFO - Running setup.py (path:/tmp/pip-GRVfqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:01 INFO - Running setup.py (path:/tmp/pip-t9_cYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:01 INFO - Running setup.py (path:/tmp/pip-uWKtSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:02 INFO - Running setup.py (path:/tmp/pip-uFbu8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:02 INFO - Running setup.py (path:/tmp/pip-j7Yh25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:02 INFO - Running setup.py (path:/tmp/pip-S2jC8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:02 INFO - Running setup.py (path:/tmp/pip-Onzqw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:02 INFO - Running setup.py (path:/tmp/pip-ib1o7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:02 INFO - Running setup.py (path:/tmp/pip-4H0ZU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:02 INFO - Running setup.py (path:/tmp/pip-98J0_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:02 INFO - Running setup.py (path:/tmp/pip-zvDDY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:02 INFO - Running setup.py install for manifestparser 11:05:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:05:02 INFO - Running setup.py install for mozcrash 11:05:02 INFO - Running setup.py install for mozdebug 11:05:02 INFO - Running setup.py install for mozdevice 11:05:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozfile 11:05:03 INFO - Running setup.py install for mozhttpd 11:05:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozinfo 11:05:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozInstall 11:05:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozleak 11:05:03 INFO - Running setup.py install for mozlog 11:05:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for moznetwork 11:05:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozprocess 11:05:03 INFO - Running setup.py install for mozprofile 11:05:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:05:03 INFO - Running setup.py install for mozrunner 11:05:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:05:04 INFO - Running setup.py install for mozscreenshot 11:05:04 INFO - Running setup.py install for moztest 11:05:04 INFO - Running setup.py install for mozversion 11:05:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:05:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:04 INFO - Cleaning up... 11:05:04 INFO - Return code: 0 11:05:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:05:04 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')]} 11:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:04 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')]} 11:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:04 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:05:04 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 11:05:04 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 11:05:04 INFO - Using env: {'DISPLAY': ':0', 11:05:04 INFO - 'HOME': '/home/cltbld', 11:05:04 INFO - 'LANG': 'en_US.UTF-8', 11:05:04 INFO - 'LANGUAGE': 'en_US:en', 11:05:04 INFO - 'LOGNAME': 'cltbld', 11:05:04 INFO - 'MAIL': '/var/mail/cltbld', 11:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:04 INFO - 'MOZ_NO_REMOTE': '1', 11:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:04 INFO - 'NO_EM_RESTART': '1', 11:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:04 INFO - 'SHELL': '/bin/bash', 11:05:04 INFO - 'SHLVL': '1', 11:05:04 INFO - 'TERM': 'linux', 11:05:04 INFO - 'TMOUT': '86400', 11:05:04 INFO - 'USER': 'cltbld', 11:05:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:04 INFO - '_': '/tools/buildbot/bin/python'} 11:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:04 INFO - Running setup.py (path:/tmp/pip-vGw624-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:05:04 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)) 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:04 INFO - Running setup.py (path:/tmp/pip-uxdtKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:05:04 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)) 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:04 INFO - Running setup.py (path:/tmp/pip-U3bR0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:05:04 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)) 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:04 INFO - Running setup.py (path:/tmp/pip-I8wdOF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:05:04 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)) 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:04 INFO - Running setup.py (path:/tmp/pip-pgx35w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:05:04 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)) 11:05:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:04 INFO - Running setup.py (path:/tmp/pip-n28SBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:05 INFO - Running setup.py (path:/tmp/pip-Y4S1BC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:05 INFO - Running setup.py (path:/tmp/pip-fb6FBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:05 INFO - Running setup.py (path:/tmp/pip-nm6oLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:05 INFO - Running setup.py (path:/tmp/pip-fv98NB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:05 INFO - Running setup.py (path:/tmp/pip-mICN67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:05 INFO - Running setup.py (path:/tmp/pip-TVJ3TE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:05 INFO - Running setup.py (path:/tmp/pip-2mTpGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:05 INFO - Running setup.py (path:/tmp/pip-NfOWTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:05 INFO - Running setup.py (path:/tmp/pip-DFS39u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:05 INFO - Running setup.py (path:/tmp/pip-nrxD3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:05:05 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)) 11:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:05 INFO - Running setup.py (path:/tmp/pip-UGXjLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:05:05 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)) 11:05:05 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)) 11:05:05 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)) 11:05:05 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)) 11:05:05 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)) 11:05:05 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)) 11:05:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:05 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 11:05:05 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 11:05:05 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 11:05:05 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 11:05:05 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 11:05:05 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 11:05:07 INFO - Downloading blessings-1.6.tar.gz 11:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:07 INFO - Installing collected packages: blessings 11:05:07 INFO - Running setup.py install for blessings 11:05:07 INFO - Successfully installed blessings 11:05:07 INFO - Cleaning up... 11:05:07 INFO - Return code: 0 11:05:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:05:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:05:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:05:08 INFO - Reading from file tmpfile_stdout 11:05:08 INFO - Current package versions: 11:05:08 INFO - argparse == 1.2.1 11:05:08 INFO - blessings == 1.6 11:05:08 INFO - blobuploader == 1.2.4 11:05:08 INFO - docopt == 0.6.1 11:05:08 INFO - manifestparser == 1.1 11:05:08 INFO - mozInstall == 1.12 11:05:08 INFO - mozcrash == 0.17 11:05:08 INFO - mozdebug == 0.1 11:05:08 INFO - mozdevice == 0.48 11:05:08 INFO - mozfile == 1.2 11:05:08 INFO - mozhttpd == 0.7 11:05:08 INFO - mozinfo == 0.9 11:05:08 INFO - mozleak == 0.1 11:05:08 INFO - mozlog == 3.1 11:05:08 INFO - moznetwork == 0.27 11:05:08 INFO - mozprocess == 0.22 11:05:08 INFO - mozprofile == 0.28 11:05:08 INFO - mozrunner == 6.11 11:05:08 INFO - mozscreenshot == 0.1 11:05:08 INFO - mozsystemmonitor == 0.0 11:05:08 INFO - moztest == 0.7 11:05:08 INFO - mozversion == 1.4 11:05:08 INFO - psutil == 3.1.1 11:05:08 INFO - requests == 1.2.3 11:05:08 INFO - wsgiref == 0.1.2 11:05:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:05:08 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')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 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')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:05:08 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 11:05:08 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 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 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)) 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:05:08 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')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 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')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:05:08 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 11:05:08 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 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:08 INFO - Downloading/unpacking jsonschema 11:05:08 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 11:05:08 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 11:05:08 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 11:05:08 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 11:05:08 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 11:05:08 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 11:05:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:10 INFO - Downloading/unpacking functools32 (from jsonschema) 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 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 11:05:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:10 INFO - warning: no files found matching '*.txt' 11:05:10 INFO - no previously-included directories found matching 'build' 11:05:10 INFO - no previously-included directories found matching 'dist' 11:05:10 INFO - no previously-included directories found matching '.git*' 11:05:10 INFO - Installing collected packages: jsonschema, functools32 11:05:10 INFO - Running setup.py install for functools32 11:05:10 INFO - warning: no files found matching '*.txt' 11:05:10 INFO - no previously-included directories found matching 'build' 11:05:10 INFO - no previously-included directories found matching 'dist' 11:05:10 INFO - no previously-included directories found matching '.git*' 11:05:10 INFO - Successfully installed jsonschema functools32 11:05:10 INFO - Cleaning up... 11:05:11 INFO - Return code: 0 11:05:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:05:11 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')]} 11:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:11 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')]} 11:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:11 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 0x7ff7c9fb7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae46d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', '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 11:05:11 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 11:05:11 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 11:05:11 INFO - Using env: {'DISPLAY': ':0', 11:05:11 INFO - 'HOME': '/home/cltbld', 11:05:11 INFO - 'LANG': 'en_US.UTF-8', 11:05:11 INFO - 'LANGUAGE': 'en_US:en', 11:05:11 INFO - 'LOGNAME': 'cltbld', 11:05:11 INFO - 'MAIL': '/var/mail/cltbld', 11:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:11 INFO - 'MOZ_NO_REMOTE': '1', 11:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:11 INFO - 'NO_EM_RESTART': '1', 11:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:11 INFO - 'SHELL': '/bin/bash', 11:05:11 INFO - 'SHLVL': '1', 11:05:11 INFO - 'TERM': 'linux', 11:05:11 INFO - 'TMOUT': '86400', 11:05:11 INFO - 'USER': 'cltbld', 11:05:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:11 INFO - '_': '/tools/buildbot/bin/python'} 11:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:11 INFO - Downloading/unpacking flake8 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:11 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 11:05:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 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 11:05:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:13 INFO - no previously-included directories found matching 'docs/_build' 11:05:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:05:13 INFO - Running setup.py install for pep8 11:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:13 INFO - no previously-included directories found matching 'docs/_build' 11:05:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:05:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:05:13 INFO - Cleaning up... 11:05:14 INFO - Return code: 0 11:05:14 INFO - Running post-action listener: _resource_record_post_action 11:05:14 INFO - Running post-action listener: _start_resource_monitoring 11:05:14 INFO - Starting resource monitoring. 11:05:14 INFO - ##### 11:05:14 INFO - ##### Running install step. 11:05:14 INFO - ##### 11:05:14 INFO - Running pre-action listener: _resource_record_pre_action 11:05:14 INFO - Running main action method: install 11:05:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:05:14 INFO - Reading from file tmpfile_stdout 11:05:14 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:05:14 INFO - Reading from file tmpfile_stdout 11:05:14 INFO - Output received: 11:05:14 INFO - Usage: mozinstall [options] installer 11:05:14 INFO - Options: 11:05:14 INFO - -h, --help show this help message and exit 11:05:14 INFO - -d DEST, --destination=DEST 11:05:14 INFO - Directory to install application into. [default: 11:05:14 INFO - "/builds/slave/test-pgo"] 11:05:14 INFO - --app=APP Application being installed. [default: firefox] 11:05:14 INFO - mkdir: /builds/slave/test-pgo/build/application 11:05:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:05:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:05:30 INFO - Reading from file tmpfile_stdout 11:05:30 INFO - Output received: 11:05:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:05:30 INFO - Running post-action listener: _resource_record_post_action 11:05:30 INFO - ##### 11:05:30 INFO - ##### Running run-tests step. 11:05:30 INFO - ##### 11:05:30 INFO - Running pre-action listener: _resource_record_pre_action 11:05:30 INFO - Running main action method: run_tests 11:05:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:05:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:05:30 INFO - Python 2.7.3 11:05:30 INFO - Return code: 0 11:05:30 INFO - grabbing minidump binary from tooltool 11:05: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')]} 11:05:30 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 0x1b73920>, '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 0x1b74820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b74cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:05:30 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 11:05:30 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 11:05:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:30 INFO - Return code: 0 11:05:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:05:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:05:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:05:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:05:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:05:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:05:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:05:31 INFO - Return code: 0 11:05:31 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/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:05:31 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/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 11:05:31 INFO - Using env: {'DISPLAY': ':0', 11:05:31 INFO - 'HOME': '/home/cltbld', 11:05:31 INFO - 'LANG': 'en_US.UTF-8', 11:05:31 INFO - 'LANGUAGE': 'en_US:en', 11:05:31 INFO - 'LOGNAME': 'cltbld', 11:05:31 INFO - 'MAIL': '/var/mail/cltbld', 11:05:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:05:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:31 INFO - 'MOZ_NO_REMOTE': '1', 11:05:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:31 INFO - 'NO_EM_RESTART': '1', 11:05:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:05:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:05:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:05:31 INFO - 'SHELL': '/bin/bash', 11:05:31 INFO - 'SHLVL': '1', 11:05:31 INFO - 'TERM': 'linux', 11:05:31 INFO - 'TMOUT': '86400', 11:05:31 INFO - 'USER': 'cltbld', 11:05:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613', 11:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:31 INFO - '_': '/tools/buildbot/bin/python'} 11:05:31 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/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:05:31 INFO - mozversion application_buildid: 20160310083118 11:05:31 INFO - mozversion application_changeset: 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 11:05:31 INFO - mozversion application_display_name: Nightly 11:05:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:31 INFO - mozversion application_name: Firefox 11:05:31 INFO - mozversion application_remotingname: firefox 11:05:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:05:31 INFO - mozversion application_vendor: Mozilla 11:05:31 INFO - mozversion application_version: 48.0a1 11:05:31 INFO - mozversion platform_buildid: 20160310083118 11:05:31 INFO - mozversion platform_changeset: 36bd53d339e68ef345ae92dbacfa749c67dcc2d0 11:05:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:05:31 INFO - mozversion platform_version: 48.0a1 11:05:31 INFO - using testdate: 1457636731 11:05:31 INFO - actual date: 1457636731 11:05:31 INFO - starting webserver on 'localhost:35339' 11:05:31 INFO - SUITE-START | Running 2 tests 11:05:31 INFO - TEST-START | dromaeo_css 11:05:31 INFO - operating with platform_type : linux_ 11:05:31 INFO - Initialising browser for dromaeo_css test... 11:05:31 INFO - TEST-INFO | started process 29208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkC6Mzy/profile http://localhost:35339/getInfo.html) 11:05:36 INFO - PROCESS | 29208 | 11:05:36 INFO - PROCESS | 29208 | (process:29291): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:37 INFO - PROCESS | 29208 | __metrics Screen width/height:1600/1200 11:05:37 INFO - PROCESS | 29208 | colorDepth:24 11:05:37 INFO - PROCESS | 29208 | Browser inner width/height: 1024/697 11:05:37 INFO - PROCESS | 29208 | __metrics 11:05:38 ERROR - PROCESS | 29208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 11:05:38 INFO - TEST-INFO | 29208: exit 0 11:05:38 INFO - Browser initialized. 11:05:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:38 INFO - TEST-INFO | started process 29343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkC6Mzy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:40 INFO - PROCESS | 29343 | 11:05:40 INFO - PROCESS | 29343 | (process:29404): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:50 INFO - PROCESS | 29343 | RSS: Main: 165396480 11:05:50 INFO - PROCESS | 29343 | 11:06:40 INFO - PROCESS | 29343 | 1457636800393 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] 11:08:49 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35339/tests/dromaeo/cssquery-ext.html) 11:08:50 INFO - PROCESS | 29343 | RSS: Main: 171171840 11:08:50 INFO - PROCESS | 29343 | 11:11:52 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-ext.html (next: http://localhost:35339/tests/dromaeo/cssquery-jquery.html) 11:11:53 INFO - PROCESS | 29343 | RSS: Main: 168845312 11:11:53 INFO - PROCESS | 29343 | 11:14:54 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35339/tests/dromaeo/cssquery-mootools.html) 11:14:55 INFO - PROCESS | 29343 | RSS: Main: 169943040 11:14:55 INFO - PROCESS | 29343 | 11:17:57 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35339/tests/dromaeo/cssquery-prototype.html) 11:17:57 INFO - PROCESS | 29343 | RSS: Main: 167886848 11:17:57 INFO - PROCESS | 29343 | 11:21:00 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35339/tests/dromaeo/cssquery-yui.html) 11:21:00 INFO - PROCESS | 29343 | RSS: Main: 168210432 11:21:00 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | Cycle 1(1): loaded http://localhost:35339/tests/dromaeo/cssquery-yui.html (next: http://localhost:35339/tests/dromaeo/cssquery-dojo.html) 11:24:03 INFO - PROCESS | 29343 | RSS: Main: 171622400 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | __start_tp_report 11:24:03 INFO - PROCESS | 29343 | _x_x_mozilla_page_load 11:24:03 INFO - PROCESS | 29343 | _x_x_mozilla_page_load_details 11:24:03 INFO - PROCESS | 29343 | |i|pagename|runs| 11:24:03 INFO - PROCESS | 29343 | |0;dojo.html;3172.9365412691745;3217.9195520112003;3224.258420563272;3234.951475727863;3252.333271679306;5085.415177254612;5090.363704536933;5096.9235461468015;5106.08090543702;5148.9959457905725;5041.067402530525;5129.2306154076905;5208.661437006592;5208.895822083556;5267.157254839227;4659.627229821623;4691.671582989192;4718.812205570628;4848.248521479177;4929.21132618781;4769.594584460325;4785.186518291899;4798.664093513456;4833.081714474256;4844.249141383074;4703.952960470403;4711.552402521755;4726;4764.666473346867;4796.784144713496;4685.906281874378;4687.20317546018;4705.482396936334;4713.151632706112;4738.763061846894;4679.064187162581;4681.274402467623;4706.176419126673;4723.551262630044;4731.858044258678;5055.823046193365;5058.949410505885;5077.949220507821;5084.339035925306;5087.3386459759995;5523.4200408956885;5532.446755324476;5533.3083364579425;5533.584981126432;5579.944200557983;5577.079781835992;5578.748956296977;5583.8883222335735;5589.74846131925;5591.692456914868;5250.238715386247;5275.340582427197;5288.101022826128;5299.9930013297735;5358;5712.685802280831;5765.654060756368;5769.798057067983;5771.624844385102;5778.971105144447;5336.919946200733;5493.368262649847;5533.584981126432;5557.888842223133;5588.888222235532;5480.671159730429;5495.340559132929;5506.779728810803;5541.0580201365865;5558.110702287615;5543.861403464945;5586.469285417878;5594.1888426177975;5594.664320140804;5646.040173170571;5360.597955153379;5425.647332923348;5425.7829686812875;5428.809991650273;5566.4990150886615;4232.767197804089;4234.618884300427;4248.256555102845;4255.1915136124035;4259.148170365939;3808.8666896658483;3812.3328417526823;3823.235352929425;3855;3865.168988667394;5204.739763011834;5275.894482110336;5285.180796976475;5321.467853214647;5340.679559226459;5535.225068490415;5607.719614019283;5609.298837645294;5610.32676078865;5647.237622920935;5283.049051170749;5289.3917199521775;5291.841244762663;5301.893962120813;5341.679499229981;4632.953670463319;4724.433068031858;4761.047790441926;4767.73777442237;4808.519148085164;5852.795152169653;5855.473007429352;5871.882562348729;5872.0898260769645;5873.823785286449;5548.4174161712435;5589.888202236014;5596.692181930033;5606.131049687305;5613.943860561342;5686.60193786431;5837.124431335334;5837.270341207349;5842.824715258549;5852.970735146468;5509.421510741475;5522.889542209214;5528.253685752533;5542.11326187808;5548.500634942713;5415.6479828811;5573.414791447002;5575.749091290821;5586.413426590312;5593.972030139823;5303.946960530499;5429.375621803385;5451.672899626035;5482.314710661168;5535.142052981794;5421.484958928895;5434.375046869661;5470.617056805985;5515.558755299647;5519.227308176778;5376.758045888023;5407.486288802557;5417.8103766367985;5432.429594892479;5501.614886957875;5398.946010539844;5436.483534064258;5478.698671572943;5480.369757477782;5520.309961254843;5267.104592219255;5295.258663786996;5380.139177731544;5478.260434841245;5478.479544443271 11:24:03 INFO - PROCESS | 29343 | |1;ext.html;526.9499397557231;539.827255278311;561.7752898840463;602.9839720071677;607.0954278125594;36600.45099323512;37770.0557486063;37870.43194352087;38064.238715225714;38081.42877856831;38047.61952380475;38642.42036369457;38737.22525549487;38740.61259387405;39014;8219.095899451055;8417.074121846592;8417.621207045668;8428.241458268754;8434.030086540035;8345.374096942724;8424.578771061453;8426.78933026673;8441.113683063282;8446.915530844704;8420.578971051453;8479.830403391928;8482.872756908651;8501;8551.700690475835;8400.83198336033;8406.579671016456;8435.662573497084;8470.534120623362;8497.830043399097;8339.416240863142;8407.747767566983;8472;8477.237048665587;8487;37497.62502374996;38136.618633813865;38421.231575368336;38430.423543646866;38438;2940.558916162571;3262.0376988788125;3290.934181316384;3303.900882973515;3400.7959522428487;27268.863655681595;27690.584641230398;27924.162275131777;28690.569641455393;28691;3810.8285127169343;3842.2507611015862;3924.156306394139;3989.962609721493;4004.539477960043;193095;193214;193597;194514;195065;53142.73428632832;56098.439015610136;56611.43388566144;56702.7164864173;56769;58936;59335.40664593385;67181.32818671751;68329.3167068323;68595.65702171557;15829.287682054335;15964.840351596567;15973.121478318571;15990.280437380346;16090.919545402197;12172.878271217352;12209.877901220874;12243.632691019284;12261.93869030667;12273.815892761615;20213.696794548094;20325;20428.489287767923;20457.48856278605;20625.381238562866;7978.401619878417;8237.8352432951;8452.070272270046;8485.618147183392;8514.361422893307;923.2244914272044;937.6952490440634;940.9294302927308;1009.8283291840405;1041.4896700616644;28552.71447285542;28883.277918051797;28898.422031559672;29191;29561.704382956326;997.6258902911409;1037.1443559063803;1039.3400190878695;1047.9161667066617;1065.4885654885697;14757.704845903021;15116.168610726516;15118.773218401733;15304.846951530342;15370;336236;336293;340656;341646;343441;52450.737746311024;52693.736531317096;52820.20769688458;52958.73520632449;52990;1308.9869101308866;1327.1307293722627;1355.7424089422977;1358.6399604105118;1366.3100134432048;27467.31331716723;28703.856480717463;28743.856280719298;28894.133176004754;29197.70802292035;46816;47200.29199561941;47382.28926566173;47478.28782568195;47553.76223118862;302232;305155;305726;306615;306701;32645.34709305753;46349.536504634525;46697.766511167225;47896.80257993578;47964.7601761989;43677.344839826794;43734.56265437305;44516;44541.33188002118;44794.3280850781;36402.817985909904;37553.43669845009;37672.4880880448;38041.42937855879;38738;37459.43810842894;37584.43623345597;37796.62203377931;37943.62056379511;38064;33678.31608419618;36717;37139.81430092832;37348.43977340397;37404.62595374011;33639.495407568415;36208.81895590505;37354.252914942095;37831.24337513289;38780.224395511366;26039.609405859304;26048.21855344343;26103.73896261089;26125.216243512725;26164 11:24:03 INFO - PROCESS | 29343 | |2;jquery.html;304.2469887029602;336.9848356823944;343.19863119615695;357.67451619026684;369.2872755581728;16401.589960250985;16477;17214.48356549304;17257.741133883002;17327.566810829736;15733.05601663901;15947.760783588226;16586;16965.406210782625;16983.3206671733;5285.6300058995885;5291.814786482474;5411.810586629469;5478.616496845202;5507.173923911405;5289.677580604849;5317.069512835258;5338.519533242007;5361.303030606015;5373.81191658292;5215.947840521584;5289.497497737709;5294.52349288564;5323.893522129555;5327.893442131155;5402.567794576425;5427.565794736412;5454.727263636842;5457.508824205841;5469.480399362054;4817.060673168733;4822.590079843218;4849.927251091236;4852.344933433977;4861.027794441091;13484.595462136152;17998;18807.341743039065;18808.62382752351;18832.62334753311;2123.299311227291;2212.8451008429415;2288.4278930267433;2657.1762753546464;2766.488199683045;8809.427387219874;8909.509976951265;8914.687985920527;9537.33238673293;9576.186024187953;1799.1813724755336;1823.972640410395;1886.9528261793564;1896.9146388412555;1957.1584218785915;54501.45498545043;61179;64027;67734.66132669355;69935.30064699339;9596.23230141587;9850.261230407748;10213.897861021294;10452.634157804441;10607.840882386616;13942.86057139436;13946.651333716738;13962.650933726738;13998;14015.159090454401;7276.7089316426745;7441.925580744231;7538.283863033003;7632.816913378435;7879.527228366316;7258.564486130849;7315.780526584104;7316.085489313836;7401;7824.804379890548;4209.789510524462;4242.257604919127;4249.235137675249;4460.977695111568;4571.451425828922;1849.990750046268;1851.4630757080297;1875.3623767918973;1880.7460992765803;1918.529960159742;966.3284017607696;987.0524296675272;1024.9692509224585;1034.8085604163255;1046.539522610049;16623.50129496117;16656.75014874778;16838.158092095593;17135;17235.65528689444;888.7733627924838;916.9495677737655;935.396669148409;950.1163917556738;1007.853861190138;9446.85829712555;9455.14903658674;9602.183814375716;9603.855942160733;9637.759056023655;337446;339913;343643;407750;417329;76282;76397;78528;79035.60482197552;81942.59028704937;1025.195221750922;1033.9172866170688;1040.9791804164026;1072.1851392941421;1077.1705786544317;15503.379864805733;15598.142102184489;15664.92167539155;15721.68556628838;15869.52391428259;32328.676713233508;32955.17612059718;33532;33596.66403335935;34349.65650343464;47650.76174619105;48420;48702.75648621734;49116.50883491119;49291.50708492869;7657.4256930731535;7664.961675191588;7681.692732290646;7784.377249819888;7815.92184078152;11519.25124866881;11678.766424671288;11885.762284754084;12097.75804483923;12245.326507042199;10692.465376731288;10741.355518668905;10813.405262710627;10951.50718217698;11180.329180249211;10661.040506354155;10708.518116684612;10874.945625271823;10940.56237750481;11277.436128193393;10656.73358166021;10887.455627218449;10947.34315941046;10962.177836662122;11271;7631.809204769926;7653.540787552764;7762.88355674654;7899.723509677134;7993.640286187252;9311.674091406769;10679.679609611723;10767.546381238746;10890.455477226265;11205.327680339205 11:24:03 INFO - PROCESS | 29343 | |3;mootools.html;1478.13529085485;1497.0643347907562;1695.5676302542856;1820.0717634006653;1862.6274745050994;6641.867162656756;7530.359919406857;7706.653200605972;7827.7260295889655;7925.4848434851765;7760.301572858441;7762.92237077629;7804.765857024298;7853;7869.449138560303;2274.488240145962;2275.0103704888343;2278.6695929090274;2290.896909639062;2296.322584837477;2191.3206905859156;2200.966985495219;2227.9331620051344;2237.2393386248673;2238.2278114050628;2179.6621523663857;2194.561087782442;2204.3386983904843;2220.367195349326;2263.841531092816;2282.8287878409187;2309.7343805462333;2323.256557901472;2327.8254130940245;2331.5453486570127;2206.4042708468783;2229.27548546723;2230.531588366445;2234.1733558583264;2241.2939923924073;7742.535447873146;7824.21757824213;7863.13505514393;7880.2513761192595;7888;4637.837675681335;4699;4703.929441058387;4748.311494833264;4754.857354279377;2948.557716342544;2985.820600862647;3131.3580715953176;3136.184592006072;3141.513065474855;988.6391467114523;990.7473594233425;1001.6293971230618;1009.4801177393648;1033.8655974723238;10690.679279621547;10852.240343175901;10920.672379828618;10924.071453926426;10924.453777311182;4311.568843115663;4366.366876802846;4443.866683999485;4444.711093778894;4463.152001119777;9353.204977576846;9357.90642093584;9365.953170234105;9368.62525498986;9413.67052153185;4841.176999910023;4877.878053048702;4887.633427492952;4895.045466134141;4901.117798796179;3718.9070273242846;4065.89835254121;4116.91766164681;4389.341598760211;4435.866923992286;3632.945505817415;3667.1932174921476;3689.0777305673582;3714.4428335749853;3718.7025037996896;1136.2898188632105;1148.5463242019523;1149.1266637355502;1157.3056166300153;1163.4415480569373;1339.5713371720956;1343.7581235377727;1346.2528296795176;1347.42060913808;1370.260059567842;7353.889691654629;7465.440091993122;7479.813004674927;7516.47384683067;7552.131504876899;473.81521206729406;475.809676129544;479.30740080583223;484.3558067769858;507.9873003174876;5767.826965191051;5773.191753154561;5792.102224155263;5826.737796799154;5840.1239814027385;8747.212750852454;9083.954580227057;9194.678186263449;9263.861042084374;9285.117913798178;9063.184313411824;9064;9068.909310906807;9092.727218183465;9143.908560914439;7078.044463997295;7157;7167.820804479826;7194.316539928698;7221.133463984355;6721.395074443323;6739;6740.764073257413;6746.460283177432;6772.221194562689;7951.403644726553;8059.1134975153855;8197.959010204911;8257.21556452136;8308.003039635283;8192.83614327722;8359.540225287668;8401.53791541471;8401.621927013177;8411.83176336482;6599.505037122139;6650.9667451662435;6780.118584583973;6804.591724496546;6857.55425897315;7598.240175982358;7603.581803000667;7616.23837616234;7638.961805191161;7648.770536883902;6743.35938085881;6839.965800170968;6856.862862742618;6957.686904089227;7002.824929376807;6778.627175505198;6825.419839313714;6835.829104272433;7000.649967501503;7012.754553590804;7182.676779544829;7215.963920180576;7306.96346518264;7341.192468828318;7378.557286562824;6699.631520266237;6743.932560674527;6753.932460675331;6756.155480564929;6789.660516974231;6537.934620653733;6587.308332625197;6597.1423714916755;6643.60138391698;6708.027336036345 11:24:03 INFO - PROCESS | 29343 | |4;prototype.html;316.5220517019301;320.67451536690254;330.8015190885469;333.21195372943;334.46485623003196;6223.346548612392;6260.530460215491;6262.060690896368;6272.968635156829;6274.811755647326;6139.263288405386;6158.59969102008;6166.414190651892;6170.858391197631;6191.75232990681;4419.712718673276;4486.7083639563325;4560.270356742922;4577.359169716243;4590.380298659672;4562.156001139783;4580.610648094916;4597.126545956257;4617.607503362218;4620.838270660528;4556.931646025312;4563.2926896330955;4566.06395688883;4580.519045500225;4581.221192397284;4544.681872268942;4563.247064234397;4565.931511027337;4567.08658268346;4574.5882870541645;3946.289667859784;3947.585503522146;3952.5256969163597;3958.8812335629977;3959.1883663848844;5762.164486149485;5908.202392676976;5943.494802941756;5944.494717948979;5958.285005799288;5216.478352164791;5243.947560524384;5265.76304066318;5276.366835979668;5288.550473209782;6505.674716264168;6560.671966401708;6564.606123632598;6565.54041217115;6575.506836987197;4251.511076226243;4258.936115958263;4272.230998420283;4280.614744672995;4283.293256612656;6772.424343930772;6807.081044059088;6848.794536163923;6851.828704282433;6861.897071543931;4294.506131794821;4339.1104823511105;4366.716163449366;4370.519242883281;4380.452443444569;4470.619997300201;4497;4503.617192538605;4503.797329120198;4508.32375143731;5270.789168433296;5286.7092309922555;5316.415194328621;5325.094733895247;5329.653572517852;6610.140681711443;6616.470682345401;6641.203055633355;6643.368879956396;6646.86706265872;1554.285028886702;1556.0119324229197;1559.2125976381853;1560.8048993875766;1563.4527915229805;994.9253805964437;995.6714284286313;1025.9076683098408;1035.9274850760373;1051.3008849115406;6256.874862502725;6269.561130720897;6276.560640755195;6277.843053923689;6288.119663247149;6748.460123190133;6751.0886030386255;6788.083608712859;6794.388505034571;6825.965870170618;6098.786542470993;6113.510919126459;6286.151369565142;6317.305096439388;6323.9683801580695;3673.68773654237;3678.981605092011;3682.7237957152784;3704.2221133561716;3711.721620878445;7231.963840180765;7265.455090868206;7306.853862922818;7310.52481588695;7314.597697126709;6975.6163411012885;6979.511434199659;6990.720371185197;7011.474139439562;7015.438764898796;7066.116735408074;7261.092363454568;7307.378872795872;7307.926920730831;7315;6777.220619628806;6779.322067793181;6802.115724955724;6806.455483561204;6854.760083397057;6770.221424536045;6776.932230677828;6779.6271205084195;6791.558548694319;6813.04617353561;7258.129024517092;7265.309795569412;7278.126624805057;7292.781216563511;7301.561906285639;4333.5016473106;4378.365137055172;4482.910341793211;4483.282674772021;4483.596476317147;6762.154730658668;6806;6816.727330906709;6824.556403833735;6864.901615741457;6644.867102658017;6654.334566543501;6659.600423974577;6661.367170118831;6672.132622759011;6621.735130594722;6626.370494803179;6650.767223147167;6657.1345725055435;6712.83217919556;6376.617402955838;6448.871022579616;6512.316206798408;6515.153030106056;6528.836779080561;6613.966930165318;6623.437007854386;6635.6350400728425;6656.36764507371;6667.19993600771;6478.6760661967655;6494.642794646151;6502.934970650233;6503.057056726653;6503.317151699003 11:24:03 INFO - PROCESS | 29343 | |5;yui.html;710.1939298895755;713.3971793834215;724.2974314914532;775.52692857357;825.607836277768;13434.261115638636;13716.794248086288;13721.03952723311;13762.243076630793;13793.51722689706;13353.732925341488;13354.532591359304;13372.331383430837;14857.257137143153;15116.924415377935;832.1553623072601;844.4342290665238;848.173031294486;849.9575021248944;852.6120615120105;816.930560902324;845.5434065604597;849.864021756519;849.9532525711084;852.0201767966826;895.1406649616376;909.1136142261308;909.7043460875209;909.7634615000081;911.2163539356148;889.4263200235844;891.4829398948626;896.6996056321141;897.4256475855458;898.4609234459338;655.6459511863588;656.6191608866845;659.3768888400464;663.7842701122155;665.3180489997743;13684.726305473934;13763.105398149088;13767.105138165987;13793.10344827583;13803.378847951866;13034.608961731068;13142.408591613304;13255.270960097287;13402.932985335108;13454.394552245074;10965.671029869116;11069.944650276697;11125.109991200685;11247.943760281229;11465.312081275068;3606.6573675500786;3632.2553876455263;3664.6518580734787;3687.2625474904858;3773.226488569864;50776.238356424685;51220.74389628028;51260;51292.743536282454;51395.74302128503;9935.205183585296;10051.497425128715;10053.69838904834;10071.143952764098;10377.221708371902;17955.461336159937;18039.458816235532;18067.54831129206;18100.45698629043;18105.63788724218;7678.462507624413;7679;7714.190010048977;7732.4200684948855;7820.17888121739;4323.654107671378;4378.627816635558;4408.228560001987;4420.624246939046;4626.398568186181;2943.249471384783;2983.970160298413;2985.447692176954;3000.4149190908;3009.0972708187455;536.9033573956647;566.5326105962597;579.1255204640938;581.9505342045974;605.0168476226132;562.3111688181945;665.7869481765788;670.3162773970523;672.8788818012707;673.6934694713893;9169.587368568431;9237.861432078524;9268.119528644767;9545.809083818423;9579.233661307218;543.4375421438792;546.4044191830924;626.9809482839657;652.546480196259;666.9129319209658;3796.4495148203355;3836.4245363195746;3899.883003509899;4011.799410029487;4042.171354872303;54082.91834163295;54547.45452545424;54727.17909231365;54733.45266547363;55382.446175538535;50597;50657.49342506528;51046.234306485436;52542.47457525452;52619;45169.54830451719;46425.071498569836;46545.30182047272;46596.53403465922;46879.76560117246;7574.204708505748;7699.538027718355;7815.29662330393;7917.841643166989;8002.639881205476;33452.1565666921;33836.830815845766;34113.658863411045;34707.65292347044;34938.12654683551;39790.40314395229;43457.78271108751;43569.128617428105;43680.78159609309;44222.557774423134;10559.607307120576;10608.204384671335;10680.252382333161;10690.144788416752;11131.053860421955;11730.413479326171;11772.234804737665;11897;12011.939940300243;12148.696282593006;10650.680479585624;10950.233483656068;11037.668869933916;11128.1653875958;11149.888501114885;10705.304155229886;11275.210735248455;11277.830832537355;11302.4913878874;11453.942730286295;10782.514786834454;10787.946060269649;10826.242163048511;10873.07578855806;10925.344479331265;8924.286057115285;8962.68630597926;9016.143466370946;9110.863337050083;9360.95319523398;8255.298299644597;8665.277423804167;8933.419327743675;9098.135677110664;9179.91493785259 11:24:03 INFO - PROCESS | 29343 | __end_tp_report 11:24:03 INFO - PROCESS | 29343 | __start_cc_report 11:24:03 INFO - PROCESS | 29343 | _x_x_mozilla_cycle_collect,350 11:24:03 INFO - PROCESS | 29343 | __end_cc_report 11:24:03 INFO - PROCESS | 29343 | __startTimestamp1457637843604__endTimestamp 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | ------- Summary: start ------- 11:24:03 INFO - PROCESS | 29343 | Number of tests: 6 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#0] dojo.html Cycles:165 Average:5183.79 Median:5398.95 stddev:571.06 (10.6%) stddev-sans-first:550.59 11:24:03 INFO - PROCESS | 29343 | Values: 3172.9 3217.9 3224.3 3235.0 3252.3 5085.4 5090.4 5096.9 5106.1 5149.0 5041.1 5129.2 5208.7 5208.9 5267.2 4659.6 4691.7 4718.8 4848.2 4929.2 4769.6 4785.2 4798.7 4833.1 4844.2 4704.0 4711.6 4726.0 4764.7 4796.8 4685.9 4687.2 4705.5 4713.2 4738.8 4679.1 4681.3 4706.2 4723.6 4731.9 5055.8 5058.9 5077.9 5084.3 5087.3 5523.4 5532.4 5533.3 5533.6 5579.9 5577.1 5578.7 5583.9 5589.7 5591.7 5250.2 5275.3 5288.1 5300.0 5358.0 5712.7 5765.7 5769.8 5771.6 5779.0 5336.9 5493.4 5533.6 5557.9 5588.9 5480.7 5495.3 5506.8 5541.1 5558.1 5543.9 5586.5 5594.2 5594.7 5646.0 5360.6 5425.6 5425.8 5428.8 5566.5 4232.8 4234.6 4248.3 4255.2 4259.1 3808.9 3812.3 3823.2 3855.0 3865.2 5204.7 5275.9 5285.2 5321.5 5340.7 5535.2 5607.7 5609.3 5610.3 5647.2 5283.0 5289.4 5291.8 5301.9 5341.7 4633.0 4724.4 4761.0 4767.7 4808.5 5852.8 5855.5 5871.9 5872.1 5873.8 5548.4 5589.9 5596.7 5606.1 5613.9 5686.6 5837.1 5837.3 5842.8 5853.0 5509.4 5522.9 5528.3 5542.1 5548.5 5415.6 5573.4 5575.7 5586.4 5594.0 5303.9 5429.4 5451.7 5482.3 5535.1 5421.5 5434.4 5470.6 5515.6 5519.2 5376.8 5407.5 5417.8 5432.4 5501.6 5398.9 5436.5 5478.7 5480.4 5520.3 5267.1 5295.3 5380.1 5478.3 5478.5 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#1] ext.html Cycles:180 Average:45779.64 Median:37907.03 stddev:75030.73 (197.9%) stddev-sans-first:75164.28 11:24:03 INFO - PROCESS | 29343 | Values: 526.9 539.8 561.8 603.0 607.1 36600.5 37770.1 37870.4 38064.2 38081.4 38047.6 38642.4 38737.2 38740.6 39014.0 8219.1 8417.1 8417.6 8428.2 8434.0 8345.4 8424.6 8426.8 8441.1 8446.9 8420.6 8479.8 8482.9 8501.0 8551.7 8400.8 8406.6 8435.7 8470.5 8497.8 8339.4 8407.7 8472.0 8477.2 8487.0 37497.6 38136.6 38421.2 38430.4 38438.0 2940.6 3262.0 3290.9 3303.9 3400.8 27268.9 27690.6 27924.2 28690.6 28691.0 3810.8 3842.3 3924.2 3990.0 4004.5 193095.0 193214.0 193597.0 194514.0 195065.0 53142.7 56098.4 56611.4 56702.7 56769.0 58936.0 59335.4 67181.3 68329.3 68595.7 15829.3 15964.8 15973.1 15990.3 16090.9 12172.9 12209.9 12243.6 12261.9 12273.8 20213.7 20325.0 20428.5 20457.5 20625.4 7978.4 8237.8 8452.1 8485.6 8514.4 923.2 937.7 940.9 1009.8 1041.5 28552.7 28883.3 28898.4 29191.0 29561.7 997.6 1037.1 1039.3 1047.9 1065.5 14757.7 15116.2 15118.8 15304.8 15370.0 336236.0 336293.0 340656.0 341646.0 343441.0 52450.7 52693.7 52820.2 52958.7 52990.0 1309.0 1327.1 1355.7 1358.6 1366.3 27467.3 28703.9 28743.9 28894.1 29197.7 46816.0 47200.3 47382.3 47478.3 47553.8 302232.0 305155.0 305726.0 306615.0 306701.0 32645.3 46349.5 46697.8 47896.8 47964.8 43677.3 43734.6 44516.0 44541.3 44794.3 36402.8 37553.4 37672.5 38041.4 38738.0 37459.4 37584.4 37796.6 37943.6 38064.0 33678.3 36717.0 37139.8 37348.4 37404.6 33639.5 36208.8 37354.3 37831.2 38780.2 26039.6 26048.2 26103.7 26125.2 26164.0 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#2] jquery.html Cycles:180 Average:23479.90 Median:188996.33 stddev:61254.07 (32.4%) stddev-sans-first:61401.19 11:24:03 INFO - PROCESS | 29343 | Values: 304.2 337.0 343.2 357.7 369.3 16401.6 16477.0 17214.5 17257.7 17327.6 15733.1 15947.8 16586.0 16965.4 16983.3 5285.6 5291.8 5411.8 5478.6 5507.2 5289.7 5317.1 5338.5 5361.3 5373.8 5215.9 5289.5 5294.5 5323.9 5327.9 5402.6 5427.6 5454.7 5457.5 5469.5 4817.1 4822.6 4849.9 4852.3 4861.0 13484.6 17998.0 18807.3 18808.6 18832.6 2123.3 2212.8 2288.4 2657.2 2766.5 8809.4 8909.5 8914.7 9537.3 9576.2 1799.2 1824.0 1887.0 1896.9 1957.2 54501.5 61179.0 64027.0 67734.7 69935.3 9596.2 9850.3 10213.9 10452.6 10607.8 13942.9 13946.7 13962.7 13998.0 14015.2 7276.7 7441.9 7538.3 7632.8 7879.5 7258.6 7315.8 7316.1 7401.0 7824.8 4209.8 4242.3 4249.2 4461.0 4571.5 1850.0 1851.5 1875.4 1880.7 1918.5 966.3 987.1 1025.0 1034.8 1046.5 16623.5 16656.8 16838.2 17135.0 17235.7 888.8 916.9 935.4 950.1 1007.9 9446.9 9455.1 9602.2 9603.9 9637.8 337446.0 339913.0 343643.0 407750.0 417329.0 76282.0 76397.0 78528.0 79035.6 81942.6 1025.2 1033.9 1041.0 1072.2 1077.2 15503.4 15598.1 15664.9 15721.7 15869.5 32328.7 32955.2 33532.0 33596.7 34349.7 47650.8 48420.0 48702.8 49116.5 49291.5 7657.4 7665.0 7681.7 7784.4 7815.9 11519.3 11678.8 11885.8 12097.8 12245.3 10692.5 10741.4 10813.4 10951.5 11180.3 10661.0 10708.5 10874.9 10940.6 11277.4 10656.7 10887.5 10947.3 10962.2 11271.0 7631.8 7653.5 7762.9 7899.7 7993.6 9311.7 10679.7 10767.5 10890.5 11205.3 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#3] mootools.html Cycles:180 Average:5441.46 Median:6598.32 stddev:2828.68 (42.9%) stddev-sans-first:2820.93 11:24:03 INFO - PROCESS | 29343 | Values: 1478.1 1497.1 1695.6 1820.1 1862.6 6641.9 7530.4 7706.7 7827.7 7925.5 7760.3 7762.9 7804.8 7853.0 7869.4 2274.5 2275.0 2278.7 2290.9 2296.3 2191.3 2201.0 2227.9 2237.2 2238.2 2179.7 2194.6 2204.3 2220.4 2263.8 2282.8 2309.7 2323.3 2327.8 2331.5 2206.4 2229.3 2230.5 2234.2 2241.3 7742.5 7824.2 7863.1 7880.3 7888.0 4637.8 4699.0 4703.9 4748.3 4754.9 2948.6 2985.8 3131.4 3136.2 3141.5 988.6 990.7 1001.6 1009.5 1033.9 10690.7 10852.2 10920.7 10924.1 10924.5 4311.6 4366.4 4443.9 4444.7 4463.2 9353.2 9357.9 9366.0 9368.6 9413.7 4841.2 4877.9 4887.6 4895.0 4901.1 3718.9 4065.9 4116.9 4389.3 4435.9 3632.9 3667.2 3689.1 3714.4 3718.7 1136.3 1148.5 1149.1 1157.3 1163.4 1339.6 1343.8 1346.3 1347.4 1370.3 7353.9 7465.4 7479.8 7516.5 7552.1 473.8 475.8 479.3 484.4 508.0 5767.8 5773.2 5792.1 5826.7 5840.1 8747.2 9084.0 9194.7 9263.9 9285.1 9063.2 9064.0 9068.9 9092.7 9143.9 7078.0 7157.0 7167.8 7194.3 7221.1 6721.4 6739.0 6740.8 6746.5 6772.2 7951.4 8059.1 8198.0 8257.2 8308.0 8192.8 8359.5 8401.5 8401.6 8411.8 6599.5 6651.0 6780.1 6804.6 6857.6 7598.2 7603.6 7616.2 7639.0 7648.8 6743.4 6840.0 6856.9 6957.7 7002.8 6778.6 6825.4 6835.8 7000.6 7012.8 7182.7 7216.0 7307.0 7341.2 7378.6 6699.6 6743.9 6753.9 6756.2 6789.7 6537.9 6587.3 6597.1 6643.6 6708.0 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#4] prototype.html Cycles:180 Average:5463.43 Median:6273.89 stddev:1731.88 (27.6%) stddev-sans-first:1693.11 11:24:03 INFO - PROCESS | 29343 | Values: 316.5 320.7 330.8 333.2 334.5 6223.3 6260.5 6262.1 6273.0 6274.8 6139.3 6158.6 6166.4 6170.9 6191.8 4419.7 4486.7 4560.3 4577.4 4590.4 4562.2 4580.6 4597.1 4617.6 4620.8 4556.9 4563.3 4566.1 4580.5 4581.2 4544.7 4563.2 4565.9 4567.1 4574.6 3946.3 3947.6 3952.5 3958.9 3959.2 5762.2 5908.2 5943.5 5944.5 5958.3 5216.5 5243.9 5265.8 5276.4 5288.6 6505.7 6560.7 6564.6 6565.5 6575.5 4251.5 4258.9 4272.2 4280.6 4283.3 6772.4 6807.1 6848.8 6851.8 6861.9 4294.5 4339.1 4366.7 4370.5 4380.5 4470.6 4497.0 4503.6 4503.8 4508.3 5270.8 5286.7 5316.4 5325.1 5329.7 6610.1 6616.5 6641.2 6643.4 6646.9 1554.3 1556.0 1559.2 1560.8 1563.5 994.9 995.7 1025.9 1035.9 1051.3 6256.9 6269.6 6276.6 6277.8 6288.1 6748.5 6751.1 6788.1 6794.4 6826.0 6098.8 6113.5 6286.2 6317.3 6324.0 3673.7 3679.0 3682.7 3704.2 3711.7 7232.0 7265.5 7306.9 7310.5 7314.6 6975.6 6979.5 6990.7 7011.5 7015.4 7066.1 7261.1 7307.4 7307.9 7315.0 6777.2 6779.3 6802.1 6806.5 6854.8 6770.2 6776.9 6779.6 6791.6 6813.0 7258.1 7265.3 7278.1 7292.8 7301.6 4333.5 4378.4 4482.9 4483.3 4483.6 6762.2 6806.0 6816.7 6824.6 6864.9 6644.9 6654.3 6659.6 6661.4 6672.1 6621.7 6626.4 6650.8 6657.1 6712.8 6376.6 6448.9 6512.3 6515.2 6528.8 6614.0 6623.4 6635.6 6656.4 6667.2 6478.7 6494.6 6502.9 6503.1 6503.3 11:24:03 INFO - PROCESS | 29343 | 11:24:03 INFO - PROCESS | 29343 | [#5] yui.html Cycles:180 Average:13752.56 Median:46485.19 stddev:15832.13 (34.1%) stddev-sans-first:15846.24 11:24:03 INFO - PROCESS | 29343 | Values: 710.2 713.4 724.3 775.5 825.6 13434.3 13716.8 13721.0 13762.2 13793.5 13353.7 13354.5 13372.3 14857.3 15116.9 832.2 844.4 848.2 850.0 852.6 816.9 845.5 849.9 850.0 852.0 895.1 909.1 909.7 909.8 911.2 889.4 891.5 896.7 897.4 898.5 655.6 656.6 659.4 663.8 665.3 13684.7 13763.1 13767.1 13793.1 13803.4 13034.6 13142.4 13255.3 13402.9 13454.4 10965.7 11069.9 11125.1 11247.9 11465.3 3606.7 3632.3 3664.7 3687.3 3773.2 50776.2 51220.7 51260.0 51292.7 51395.7 9935.2 10051.5 10053.7 10071.1 10377.2 17955.5 18039.5 18067.5 18100.5 18105.6 7678.5 7679.0 7714.2 7732.4 7820.2 4323.7 4378.6 4408.2 4420.6 4626.4 2943.2 2984.0 2985.4 3000.4 3009.1 536.9 566.5 579.1 582.0 605.0 562.3 665.8 670.3 672.9 673.7 9169.6 9237.9 9268.1 9545.8 9579.2 543.4 546.4 627.0 652.5 666.9 3796.4 3836.4 3899.9 4011.8 4042.2 54082.9 54547.5 54727.2 54733.5 55382.4 50597.0 50657.5 51046.2 52542.5 52619.0 45169.5 46425.1 46545.3 46596.5 46879.8 7574.2 7699.5 7815.3 7917.8 8002.6 33452.2 33836.8 34113.7 34707.7 34938.1 39790.4 43457.8 43569.1 43680.8 44222.6 10559.6 10608.2 10680.3 10690.1 11131.1 11730.4 11772.2 11897.0 12011.9 12148.7 10650.7 10950.2 11037.7 11128.2 11149.9 10705.3 11275.2 11277.8 11302.5 11453.9 10782.5 10787.9 10826.2 10873.1 10925.3 8924.3 8962.7 9016.1 9110.9 9361.0 8255.3 8665.3 8933.4 9098.1 9179.9 11:24:03 INFO - PROCESS | 29343 | -------- Summary: end -------- 11:24:03 INFO - PROCESS | 29343 | 11:24:04 INFO - TEST-INFO | 29343: exit 0 11:24:04 INFO - TEST-OK | dromaeo_css | took 1112627ms 11:24:04 INFO - TEST-START | kraken 11:24:04 INFO - operating with platform_type : linux_ 11:24:04 INFO - Initialising browser for kraken test... 11:24:04 INFO - TEST-INFO | started process 29584 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppRFRJ8/profile http://localhost:35339/getInfo.html) 11:24:08 INFO - PROCESS | 29584 | 11:24:08 INFO - PROCESS | 29584 | (process:29656): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:24:09 INFO - PROCESS | 29584 | __metrics Screen width/height:1600/1200 11:24:09 INFO - PROCESS | 29584 | colorDepth:24 11:24:09 INFO - PROCESS | 29584 | Browser inner width/height: 1024/697 11:24:09 INFO - PROCESS | 29584 | __metrics 11:24:10 ERROR - PROCESS | 29584 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 11:24:11 INFO - TEST-INFO | 29584: exit 0 11:24:11 INFO - Browser initialized. 11:24:11 INFO - Running cycle 1/1 for kraken test... 11:24:11 INFO - TEST-INFO | started process 29708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppRFRJ8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:12 INFO - PROCESS | 29708 | 11:24:12 INFO - PROCESS | 29708 | (process:29771): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:24:22 INFO - PROCESS | 29708 | RSS: Main: 166531072 11:24:22 INFO - PROCESS | 29708 | 11:24:25 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35339/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:26 INFO - PROCESS | 29708 | RSS: Main: 171352064 11:24:26 INFO - PROCESS | 29708 | 11:24:28 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35339/tests/kraken/driver.html?testName=audio-dft) 11:24:29 INFO - PROCESS | 29708 | RSS: Main: 172142592 11:24:29 INFO - PROCESS | 29708 | 11:24:32 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35339/tests/kraken/driver.html?testName=audio-fft) 11:24:32 INFO - PROCESS | 29708 | RSS: Main: 168177664 11:24:32 INFO - PROCESS | 29708 | 11:24:34 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35339/tests/kraken/driver.html?testName=audio-oscillator) 11:24:35 INFO - PROCESS | 29708 | RSS: Main: 166772736 11:24:35 INFO - PROCESS | 29708 | 11:24:37 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:38 INFO - PROCESS | 29708 | RSS: Main: 167272448 11:24:38 INFO - PROCESS | 29708 | 11:24:41 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35339/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:42 INFO - PROCESS | 29708 | RSS: Main: 167002112 11:24:42 INFO - PROCESS | 29708 | 11:24:45 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35339/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:46 INFO - PROCESS | 29708 | RSS: Main: 167399424 11:24:46 INFO - PROCESS | 29708 | 11:24:48 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35339/tests/kraken/driver.html?testName=json-parse-financial) 11:24:49 INFO - PROCESS | 29708 | RSS: Main: 169324544 11:24:49 INFO - PROCESS | 29708 | 11:24:51 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:51 INFO - PROCESS | 29708 | RSS: Main: 170954752 11:24:51 INFO - PROCESS | 29708 | 11:24:53 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:54 INFO - PROCESS | 29708 | RSS: Main: 169734144 11:24:54 INFO - PROCESS | 29708 | 11:24:56 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:24:56 INFO - PROCESS | 29708 | RSS: Main: 169574400 11:24:56 INFO - PROCESS | 29708 | 11:24:59 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:24:59 INFO - PROCESS | 29708 | RSS: Main: 169562112 11:24:59 INFO - PROCESS | 29708 | 11:25:02 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:02 INFO - PROCESS | 29708 | RSS: Main: 170184704 11:25:02 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | Cycle 1(1): loaded http://localhost:35339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35339/tests/kraken/driver.html?testName=ai-astar) 11:25:04 INFO - PROCESS | 29708 | RSS: Main: 171667456 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | __start_tp_report 11:25:04 INFO - PROCESS | 29708 | _x_x_mozilla_page_load 11:25:04 INFO - PROCESS | 29708 | _x_x_mozilla_page_load_details 11:25:04 INFO - PROCESS | 29708 | |i|pagename|runs| 11:25:04 INFO - PROCESS | 29708 | |0;ai-astar;113;105;111;112;110;123;110;111;111;112 11:25:04 INFO - PROCESS | 29708 | |1;audio-beat-detection;152;125;155;170;129;158;165;130;168;128 11:25:04 INFO - PROCESS | 29708 | |2;audio-dft;160;162;163;162;162;162;164;165;169;163 11:25:04 INFO - PROCESS | 29708 | |3;audio-fft;72;74;75;80;76;75;76;79;149;73 11:25:04 INFO - PROCESS | 29708 | |4;audio-oscillator;97;94;142;93;93;94;142;93;94;136 11:25:04 INFO - PROCESS | 29708 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;119;119;118 11:25:04 INFO - PROCESS | 29708 | |6;imaging-darkroom;147;146;147;147;146;146;147;146;147;146 11:25:04 INFO - PROCESS | 29708 | |7;imaging-desaturate;97;96;96;97;96;97;96;96;96;95 11:25:04 INFO - PROCESS | 29708 | |8;json-parse-financial;60;57;63;63;59;58;61;58;64;56 11:25:04 INFO - PROCESS | 29708 | |9;json-stringify-tinderbox;69;69;68;69;70;68;69;69;69;70 11:25:04 INFO - PROCESS | 29708 | |10;stanford-crypto-aes;83;83;83;83;83;84;85;85;84;83 11:25:04 INFO - PROCESS | 29708 | |11;stanford-crypto-ccm;121;119;114;123;130;118;115;123;118;114 11:25:04 INFO - PROCESS | 29708 | |12;stanford-crypto-pbkdf2;134;145;144;142;146;137;144;144;145;133 11:25:04 INFO - PROCESS | 29708 | |13;stanford-crypto-sha256-iterative;70;67;72;69;69;68;69;71;69;70 11:25:04 INFO - PROCESS | 29708 | __end_tp_report 11:25:04 INFO - PROCESS | 29708 | __start_cc_report 11:25:04 INFO - PROCESS | 29708 | _x_x_mozilla_cycle_collect,829 11:25:04 INFO - PROCESS | 29708 | __end_cc_report 11:25:04 INFO - PROCESS | 29708 | __startTimestamp1457637904961__endTimestamp 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | ------- Summary: start ------- 11:25:04 INFO - PROCESS | 29708 | Number of tests: 14 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:4.49 (4.0%) stddev-sans-first:4.74 11:25:04 INFO - PROCESS | 29708 | Values: 113.0 105.0 111.0 112.0 110.0 123.0 110.0 111.0 111.0 112.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:156.50 stddev:18.11 (11.6%) stddev-sans-first:19.15 11:25:04 INFO - PROCESS | 29708 | Values: 152.0 125.0 155.0 170.0 129.0 158.0 165.0 130.0 168.0 128.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.44 (1.5%) stddev-sans-first:2.30 11:25:04 INFO - PROCESS | 29708 | Values: 160.0 162.0 163.0 162.0 162.0 162.0 164.0 165.0 169.0 163.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:23.35 (30.9%) stddev-sans-first:24.44 11:25:04 INFO - PROCESS | 29708 | Values: 72.0 74.0 75.0 80.0 76.0 75.0 76.0 79.0 149.0 73.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.50 stddev:22.31 (23.9%) stddev-sans-first:23.32 11:25:04 INFO - PROCESS | 29708 | Values: 97.0 94.0 142.0 93.0 93.0 94.0 142.0 93.0 94.0 136.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 11:25:04 INFO - PROCESS | 29708 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 119.0 119.0 118.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:25:04 INFO - PROCESS | 29708 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:25:04 INFO - PROCESS | 29708 | Values: 97.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 95.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.50 stddev:2.77 (4.6%) stddev-sans-first:2.93 11:25:04 INFO - PROCESS | 29708 | Values: 60.0 57.0 63.0 63.0 59.0 58.0 61.0 58.0 64.0 56.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:25:04 INFO - PROCESS | 29708 | Values: 69.0 69.0 68.0 69.0 70.0 68.0 69.0 69.0 69.0 70.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:0.84 (1.0%) stddev-sans-first:0.87 11:25:04 INFO - PROCESS | 29708 | Values: 83.0 83.0 83.0 83.0 83.0 84.0 85.0 85.0 84.0 83.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:120.00 stddev:4.97 (4.1%) stddev-sans-first:5.24 11:25:04 INFO - PROCESS | 29708 | Values: 121.0 119.0 114.0 123.0 130.0 118.0 115.0 123.0 118.0 114.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:144.00 stddev:4.86 (3.4%) stddev-sans-first:4.35 11:25:04 INFO - PROCESS | 29708 | Values: 134.0 145.0 144.0 142.0 146.0 137.0 144.0 144.0 145.0 133.0 11:25:04 INFO - PROCESS | 29708 | 11:25:04 INFO - PROCESS | 29708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.43 (2.1%) stddev-sans-first:1.50 11:25:04 INFO - PROCESS | 29708 | Values: 70.0 67.0 72.0 69.0 69.0 68.0 69.0 71.0 69.0 70.0 11:25:04 INFO - PROCESS | 29708 | -------- Summary: end -------- 11:25:04 INFO - PROCESS | 29708 | 11:25:05 INFO - TEST-INFO | 29708: exit 0 11:25:05 INFO - TEST-OK | kraken | took 61638ms 11:25:05 INFO - SUITE-END | took 1174s 11:25:06 INFO - Completed test suite (00:19:34) 11:25:06 INFO - javascript benchmark 11:25:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.9365412691745, 3217.9195520112003, 3224.258420563272, 3234.951475727863, 3252.333271679306, 5085.415177254612, 5090.363704536933, 5096.9235461468015, 5106.08090543702, 5148.9959457905725, 5041.067402530525, 5129.2306154076905, 5208.661437006592, 5208.895822083556, 5267.157254839227, 4659.627229821623, 4691.671582989192, 4718.812205570628, 4848.248521479177, 4929.21132618781, 4769.594584460325, 4785.186518291899, 4798.664093513456, 4833.081714474256, 4844.249141383074, 4703.952960470403, 4711.552402521755, 4726.0, 4764.666473346867, 4796.784144713496, 4685.906281874378, 4687.20317546018, 4705.482396936334, 4713.151632706112, 4738.763061846894, 4679.064187162581, 4681.274402467623, 4706.176419126673, 4723.551262630044, 4731.858044258678, 5055.823046193365, 5058.949410505885, 5077.949220507821, 5084.339035925306, 5087.3386459759995, 5523.4200408956885, 5532.446755324476, 5533.3083364579425, 5533.584981126432, 5579.944200557983, 5577.079781835992, 5578.748956296977, 5583.8883222335735, 5589.74846131925, 5591.692456914868, 5250.238715386247, 5275.340582427197, 5288.101022826128, 5299.9930013297735, 5358.0, 5712.685802280831, 5765.654060756368, 5769.798057067983, 5771.624844385102, 5778.971105144447, 5336.919946200733, 5493.368262649847, 5533.584981126432, 5557.888842223133, 5588.888222235532, 5480.671159730429, 5495.340559132929, 5506.779728810803, 5541.0580201365865, 5558.110702287615, 5543.861403464945, 5586.469285417878, 5594.1888426177975, 5594.664320140804, 5646.040173170571, 5360.597955153379, 5425.647332923348, 5425.7829686812875, 5428.809991650273, 5566.4990150886615, 4232.767197804089, 4234.618884300427, 4248.256555102845, 4255.1915136124035, 4259.148170365939, 3808.8666896658483, 3812.3328417526823, 3823.235352929425, 3855.0, 3865.168988667394, 5204.739763011834, 5275.894482110336, 5285.180796976475, 5321.467853214647, 5340.679559226459, 5535.225068490415, 5607.719614019283, 5609.298837645294, 5610.32676078865, 5647.237622920935, 5283.049051170749, 5289.3917199521775, 5291.841244762663, 5301.893962120813, 5341.679499229981, 4632.953670463319, 4724.433068031858, 4761.047790441926, 4767.73777442237, 4808.519148085164, 5852.795152169653, 5855.473007429352, 5871.882562348729, 5872.0898260769645, 5873.823785286449, 5548.4174161712435, 5589.888202236014, 5596.692181930033, 5606.131049687305, 5613.943860561342, 5686.60193786431, 5837.124431335334, 5837.270341207349, 5842.824715258549, 5852.970735146468, 5509.421510741475, 5522.889542209214, 5528.253685752533, 5542.11326187808, 5548.500634942713, 5415.6479828811, 5573.414791447002, 5575.749091290821, 5586.413426590312, 5593.972030139823, 5303.946960530499, 5429.375621803385, 5451.672899626035, 5482.314710661168, 5535.142052981794, 5421.484958928895, 5434.375046869661, 5470.617056805985, 5515.558755299647, 5519.227308176778, 5376.758045888023, 5407.486288802557, 5417.8103766367985, 5432.429594892479, 5501.614886957875, 5398.946010539844, 5436.483534064258, 5478.698671572943, 5480.369757477782, 5520.309961254843, 5267.104592219255, 5295.258663786996, 5380.139177731544, 5478.260434841245, 5478.479544443271], "unit": "score", "name": "dojo.html", "value": 5147.610591241117}, {"lowerIsBetter": false, "replicates": [526.9499397557231, 539.827255278311, 561.7752898840463, 602.9839720071677, 607.0954278125594, 36600.45099323512, 37770.0557486063, 37870.43194352087, 38064.238715225714, 38081.42877856831, 38047.61952380475, 38642.42036369457, 38737.22525549487, 38740.61259387405, 39014.0, 8219.095899451055, 8417.074121846592, 8417.621207045668, 8428.241458268754, 8434.030086540035, 8345.374096942724, 8424.578771061453, 8426.78933026673, 8441.113683063282, 8446.915530844704, 8420.578971051453, 8479.830403391928, 8482.872756908651, 8501.0, 8551.700690475835, 8400.83198336033, 8406.579671016456, 8435.662573497084, 8470.534120623362, 8497.830043399097, 8339.416240863142, 8407.747767566983, 8472.0, 8477.237048665587, 8487.0, 37497.62502374996, 38136.618633813865, 38421.231575368336, 38430.423543646866, 38438.0, 2940.558916162571, 3262.0376988788125, 3290.934181316384, 3303.900882973515, 3400.7959522428487, 27268.863655681595, 27690.584641230398, 27924.162275131777, 28690.569641455393, 28691.0, 3810.8285127169343, 3842.2507611015862, 3924.156306394139, 3989.962609721493, 4004.539477960043, 193095.0, 193214.0, 193597.0, 194514.0, 195065.0, 53142.73428632832, 56098.439015610136, 56611.43388566144, 56702.7164864173, 56769.0, 58936.0, 59335.40664593385, 67181.32818671751, 68329.3167068323, 68595.65702171557, 15829.287682054335, 15964.840351596567, 15973.121478318571, 15990.280437380346, 16090.919545402197, 12172.878271217352, 12209.877901220874, 12243.632691019284, 12261.93869030667, 12273.815892761615, 20213.696794548094, 20325.0, 20428.489287767923, 20457.48856278605, 20625.381238562866, 7978.401619878417, 8237.8352432951, 8452.070272270046, 8485.618147183392, 8514.361422893307, 923.2244914272044, 937.6952490440634, 940.9294302927308, 1009.8283291840405, 1041.4896700616644, 28552.71447285542, 28883.277918051797, 28898.422031559672, 29191.0, 29561.704382956326, 997.6258902911409, 1037.1443559063803, 1039.3400190878695, 1047.9161667066617, 1065.4885654885697, 14757.704845903021, 15116.168610726516, 15118.773218401733, 15304.846951530342, 15370.0, 336236.0, 336293.0, 340656.0, 341646.0, 343441.0, 52450.737746311024, 52693.736531317096, 52820.20769688458, 52958.73520632449, 52990.0, 1308.9869101308866, 1327.1307293722627, 1355.7424089422977, 1358.6399604105118, 1366.3100134432048, 27467.31331716723, 28703.856480717463, 28743.856280719298, 28894.133176004754, 29197.70802292035, 46816.0, 47200.29199561941, 47382.28926566173, 47478.28782568195, 47553.76223118862, 302232.0, 305155.0, 305726.0, 306615.0, 306701.0, 32645.34709305753, 46349.536504634525, 46697.766511167225, 47896.80257993578, 47964.7601761989, 43677.344839826794, 43734.56265437305, 44516.0, 44541.33188002118, 44794.3280850781, 36402.817985909904, 37553.43669845009, 37672.4880880448, 38041.42937855879, 38738.0, 37459.43810842894, 37584.43623345597, 37796.62203377931, 37943.62056379511, 38064.0, 33678.31608419618, 36717.0, 37139.81430092832, 37348.43977340397, 37404.62595374011, 33639.495407568415, 36208.81895590505, 37354.252914942095, 37831.24337513289, 38780.224395511366, 26039.609405859304, 26048.21855344343, 26103.73896261089, 26125.216243512725, 26164.0], "unit": "score", "name": "ext.html", "value": 18573.842029506428}, {"lowerIsBetter": false, "replicates": [304.2469887029602, 336.9848356823944, 343.19863119615695, 357.67451619026684, 369.2872755581728, 16401.589960250985, 16477.0, 17214.48356549304, 17257.741133883002, 17327.566810829736, 15733.05601663901, 15947.760783588226, 16586.0, 16965.406210782625, 16983.3206671733, 5285.6300058995885, 5291.814786482474, 5411.810586629469, 5478.616496845202, 5507.173923911405, 5289.677580604849, 5317.069512835258, 5338.519533242007, 5361.303030606015, 5373.81191658292, 5215.947840521584, 5289.497497737709, 5294.52349288564, 5323.893522129555, 5327.893442131155, 5402.567794576425, 5427.565794736412, 5454.727263636842, 5457.508824205841, 5469.480399362054, 4817.060673168733, 4822.590079843218, 4849.927251091236, 4852.344933433977, 4861.027794441091, 13484.595462136152, 17998.0, 18807.341743039065, 18808.62382752351, 18832.62334753311, 2123.299311227291, 2212.8451008429415, 2288.4278930267433, 2657.1762753546464, 2766.488199683045, 8809.427387219874, 8909.509976951265, 8914.687985920527, 9537.33238673293, 9576.186024187953, 1799.1813724755336, 1823.972640410395, 1886.9528261793564, 1896.9146388412555, 1957.1584218785915, 54501.45498545043, 61179.0, 64027.0, 67734.66132669355, 69935.30064699339, 9596.23230141587, 9850.261230407748, 10213.897861021294, 10452.634157804441, 10607.840882386616, 13942.86057139436, 13946.651333716738, 13962.650933726738, 13998.0, 14015.159090454401, 7276.7089316426745, 7441.925580744231, 7538.283863033003, 7632.816913378435, 7879.527228366316, 7258.564486130849, 7315.780526584104, 7316.085489313836, 7401.0, 7824.804379890548, 4209.789510524462, 4242.257604919127, 4249.235137675249, 4460.977695111568, 4571.451425828922, 1849.990750046268, 1851.4630757080297, 1875.3623767918973, 1880.7460992765803, 1918.529960159742, 966.3284017607696, 987.0524296675272, 1024.9692509224585, 1034.8085604163255, 1046.539522610049, 16623.50129496117, 16656.75014874778, 16838.158092095593, 17135.0, 17235.65528689444, 888.7733627924838, 916.9495677737655, 935.396669148409, 950.1163917556738, 1007.853861190138, 9446.85829712555, 9455.14903658674, 9602.183814375716, 9603.855942160733, 9637.759056023655, 337446.0, 339913.0, 343643.0, 407750.0, 417329.0, 76282.0, 76397.0, 78528.0, 79035.60482197552, 81942.59028704937, 1025.195221750922, 1033.9172866170688, 1040.9791804164026, 1072.1851392941421, 1077.1705786544317, 15503.379864805733, 15598.142102184489, 15664.92167539155, 15721.68556628838, 15869.52391428259, 32328.676713233508, 32955.17612059718, 33532.0, 33596.66403335935, 34349.65650343464, 47650.76174619105, 48420.0, 48702.75648621734, 49116.50883491119, 49291.50708492869, 7657.4256930731535, 7664.961675191588, 7681.692732290646, 7784.377249819888, 7815.92184078152, 11519.25124866881, 11678.766424671288, 11885.762284754084, 12097.75804483923, 12245.326507042199, 10692.465376731288, 10741.355518668905, 10813.405262710627, 10951.50718217698, 11180.329180249211, 10661.040506354155, 10708.518116684612, 10874.945625271823, 10940.56237750481, 11277.436128193393, 10656.73358166021, 10887.455627218449, 10947.34315941046, 10962.177836662122, 11271.0, 7631.809204769926, 7653.540787552764, 7762.88355674654, 7899.723509677134, 7993.640286187252, 9311.674091406769, 10679.679609611723, 10767.546381238746, 10890.455477226265, 11205.327680339205], "unit": "score", "name": "jquery.html", "value": 8320.53716485842}, {"lowerIsBetter": false, "replicates": [1478.13529085485, 1497.0643347907562, 1695.5676302542856, 1820.0717634006653, 1862.6274745050994, 6641.867162656756, 7530.359919406857, 7706.653200605972, 7827.7260295889655, 7925.4848434851765, 7760.301572858441, 7762.92237077629, 7804.765857024298, 7853.0, 7869.449138560303, 2274.488240145962, 2275.0103704888343, 2278.6695929090274, 2290.896909639062, 2296.322584837477, 2191.3206905859156, 2200.966985495219, 2227.9331620051344, 2237.2393386248673, 2238.2278114050628, 2179.6621523663857, 2194.561087782442, 2204.3386983904843, 2220.367195349326, 2263.841531092816, 2282.8287878409187, 2309.7343805462333, 2323.256557901472, 2327.8254130940245, 2331.5453486570127, 2206.4042708468783, 2229.27548546723, 2230.531588366445, 2234.1733558583264, 2241.2939923924073, 7742.535447873146, 7824.21757824213, 7863.13505514393, 7880.2513761192595, 7888.0, 4637.837675681335, 4699.0, 4703.929441058387, 4748.311494833264, 4754.857354279377, 2948.557716342544, 2985.820600862647, 3131.3580715953176, 3136.184592006072, 3141.513065474855, 988.6391467114523, 990.7473594233425, 1001.6293971230618, 1009.4801177393648, 1033.8655974723238, 10690.679279621547, 10852.240343175901, 10920.672379828618, 10924.071453926426, 10924.453777311182, 4311.568843115663, 4366.366876802846, 4443.866683999485, 4444.711093778894, 4463.152001119777, 9353.204977576846, 9357.90642093584, 9365.953170234105, 9368.62525498986, 9413.67052153185, 4841.176999910023, 4877.878053048702, 4887.633427492952, 4895.045466134141, 4901.117798796179, 3718.9070273242846, 4065.89835254121, 4116.91766164681, 4389.341598760211, 4435.866923992286, 3632.945505817415, 3667.1932174921476, 3689.0777305673582, 3714.4428335749853, 3718.7025037996896, 1136.2898188632105, 1148.5463242019523, 1149.1266637355502, 1157.3056166300153, 1163.4415480569373, 1339.5713371720956, 1343.7581235377727, 1346.2528296795176, 1347.42060913808, 1370.260059567842, 7353.889691654629, 7465.440091993122, 7479.813004674927, 7516.47384683067, 7552.131504876899, 473.81521206729406, 475.809676129544, 479.30740080583223, 484.3558067769858, 507.9873003174876, 5767.826965191051, 5773.191753154561, 5792.102224155263, 5826.737796799154, 5840.1239814027385, 8747.212750852454, 9083.954580227057, 9194.678186263449, 9263.861042084374, 9285.117913798178, 9063.184313411824, 9064.0, 9068.909310906807, 9092.727218183465, 9143.908560914439, 7078.044463997295, 7157.0, 7167.820804479826, 7194.316539928698, 7221.133463984355, 6721.395074443323, 6739.0, 6740.764073257413, 6746.460283177432, 6772.221194562689, 7951.403644726553, 8059.1134975153855, 8197.959010204911, 8257.21556452136, 8308.003039635283, 8192.83614327722, 8359.540225287668, 8401.53791541471, 8401.621927013177, 8411.83176336482, 6599.505037122139, 6650.9667451662435, 6780.118584583973, 6804.591724496546, 6857.55425897315, 7598.240175982358, 7603.581803000667, 7616.23837616234, 7638.961805191161, 7648.770536883902, 6743.35938085881, 6839.965800170968, 6856.862862742618, 6957.686904089227, 7002.824929376807, 6778.627175505198, 6825.419839313714, 6835.829104272433, 7000.649967501503, 7012.754553590804, 7182.676779544829, 7215.963920180576, 7306.96346518264, 7341.192468828318, 7378.557286562824, 6699.631520266237, 6743.932560674527, 6753.932460675331, 6756.155480564929, 6789.660516974231, 6537.934620653733, 6587.308332625197, 6597.1423714916755, 6643.60138391698, 6708.027336036345], "unit": "score", "name": "mootools.html", "value": 4405.4305088307565}, {"lowerIsBetter": false, "replicates": [316.5220517019301, 320.67451536690254, 330.8015190885469, 333.21195372943, 334.46485623003196, 6223.346548612392, 6260.530460215491, 6262.060690896368, 6272.968635156829, 6274.811755647326, 6139.263288405386, 6158.59969102008, 6166.414190651892, 6170.858391197631, 6191.75232990681, 4419.712718673276, 4486.7083639563325, 4560.270356742922, 4577.359169716243, 4590.380298659672, 4562.156001139783, 4580.610648094916, 4597.126545956257, 4617.607503362218, 4620.838270660528, 4556.931646025312, 4563.2926896330955, 4566.06395688883, 4580.519045500225, 4581.221192397284, 4544.681872268942, 4563.247064234397, 4565.931511027337, 4567.08658268346, 4574.5882870541645, 3946.289667859784, 3947.585503522146, 3952.5256969163597, 3958.8812335629977, 3959.1883663848844, 5762.164486149485, 5908.202392676976, 5943.494802941756, 5944.494717948979, 5958.285005799288, 5216.478352164791, 5243.947560524384, 5265.76304066318, 5276.366835979668, 5288.550473209782, 6505.674716264168, 6560.671966401708, 6564.606123632598, 6565.54041217115, 6575.506836987197, 4251.511076226243, 4258.936115958263, 4272.230998420283, 4280.614744672995, 4283.293256612656, 6772.424343930772, 6807.081044059088, 6848.794536163923, 6851.828704282433, 6861.897071543931, 4294.506131794821, 4339.1104823511105, 4366.716163449366, 4370.519242883281, 4380.452443444569, 4470.619997300201, 4497.0, 4503.617192538605, 4503.797329120198, 4508.32375143731, 5270.789168433296, 5286.7092309922555, 5316.415194328621, 5325.094733895247, 5329.653572517852, 6610.140681711443, 6616.470682345401, 6641.203055633355, 6643.368879956396, 6646.86706265872, 1554.285028886702, 1556.0119324229197, 1559.2125976381853, 1560.8048993875766, 1563.4527915229805, 994.9253805964437, 995.6714284286313, 1025.9076683098408, 1035.9274850760373, 1051.3008849115406, 6256.874862502725, 6269.561130720897, 6276.560640755195, 6277.843053923689, 6288.119663247149, 6748.460123190133, 6751.0886030386255, 6788.083608712859, 6794.388505034571, 6825.965870170618, 6098.786542470993, 6113.510919126459, 6286.151369565142, 6317.305096439388, 6323.9683801580695, 3673.68773654237, 3678.981605092011, 3682.7237957152784, 3704.2221133561716, 3711.721620878445, 7231.963840180765, 7265.455090868206, 7306.853862922818, 7310.52481588695, 7314.597697126709, 6975.6163411012885, 6979.511434199659, 6990.720371185197, 7011.474139439562, 7015.438764898796, 7066.116735408074, 7261.092363454568, 7307.378872795872, 7307.926920730831, 7315.0, 6777.220619628806, 6779.322067793181, 6802.115724955724, 6806.455483561204, 6854.760083397057, 6770.221424536045, 6776.932230677828, 6779.6271205084195, 6791.558548694319, 6813.04617353561, 7258.129024517092, 7265.309795569412, 7278.126624805057, 7292.781216563511, 7301.561906285639, 4333.5016473106, 4378.365137055172, 4482.910341793211, 4483.282674772021, 4483.596476317147, 6762.154730658668, 6806.0, 6816.727330906709, 6824.556403833735, 6864.901615741457, 6644.867102658017, 6654.334566543501, 6659.600423974577, 6661.367170118831, 6672.132622759011, 6621.735130594722, 6626.370494803179, 6650.767223147167, 6657.1345725055435, 6712.83217919556, 6376.617402955838, 6448.871022579616, 6512.316206798408, 6515.153030106056, 6528.836779080561, 6613.966930165318, 6623.437007854386, 6635.6350400728425, 6656.36764507371, 6667.19993600771, 6478.6760661967655, 6494.642794646151, 6502.934970650233, 6503.057056726653, 6503.317151699003], "unit": "score", "name": "prototype.html", "value": 4887.286582430285}, {"lowerIsBetter": false, "replicates": [710.1939298895755, 713.3971793834215, 724.2974314914532, 775.52692857357, 825.607836277768, 13434.261115638636, 13716.794248086288, 13721.03952723311, 13762.243076630793, 13793.51722689706, 13353.732925341488, 13354.532591359304, 13372.331383430837, 14857.257137143153, 15116.924415377935, 832.1553623072601, 844.4342290665238, 848.173031294486, 849.9575021248944, 852.6120615120105, 816.930560902324, 845.5434065604597, 849.864021756519, 849.9532525711084, 852.0201767966826, 895.1406649616376, 909.1136142261308, 909.7043460875209, 909.7634615000081, 911.2163539356148, 889.4263200235844, 891.4829398948626, 896.6996056321141, 897.4256475855458, 898.4609234459338, 655.6459511863588, 656.6191608866845, 659.3768888400464, 663.7842701122155, 665.3180489997743, 13684.726305473934, 13763.105398149088, 13767.105138165987, 13793.10344827583, 13803.378847951866, 13034.608961731068, 13142.408591613304, 13255.270960097287, 13402.932985335108, 13454.394552245074, 10965.671029869116, 11069.944650276697, 11125.109991200685, 11247.943760281229, 11465.312081275068, 3606.6573675500786, 3632.2553876455263, 3664.6518580734787, 3687.2625474904858, 3773.226488569864, 50776.238356424685, 51220.74389628028, 51260.0, 51292.743536282454, 51395.74302128503, 9935.205183585296, 10051.497425128715, 10053.69838904834, 10071.143952764098, 10377.221708371902, 17955.461336159937, 18039.458816235532, 18067.54831129206, 18100.45698629043, 18105.63788724218, 7678.462507624413, 7679.0, 7714.190010048977, 7732.4200684948855, 7820.17888121739, 4323.654107671378, 4378.627816635558, 4408.228560001987, 4420.624246939046, 4626.398568186181, 2943.249471384783, 2983.970160298413, 2985.447692176954, 3000.4149190908, 3009.0972708187455, 536.9033573956647, 566.5326105962597, 579.1255204640938, 581.9505342045974, 605.0168476226132, 562.3111688181945, 665.7869481765788, 670.3162773970523, 672.8788818012707, 673.6934694713893, 9169.587368568431, 9237.861432078524, 9268.119528644767, 9545.809083818423, 9579.233661307218, 543.4375421438792, 546.4044191830924, 626.9809482839657, 652.546480196259, 666.9129319209658, 3796.4495148203355, 3836.4245363195746, 3899.883003509899, 4011.799410029487, 4042.171354872303, 54082.91834163295, 54547.45452545424, 54727.17909231365, 54733.45266547363, 55382.446175538535, 50597.0, 50657.49342506528, 51046.234306485436, 52542.47457525452, 52619.0, 45169.54830451719, 46425.071498569836, 46545.30182047272, 46596.53403465922, 46879.76560117246, 7574.204708505748, 7699.538027718355, 7815.29662330393, 7917.841643166989, 8002.639881205476, 33452.1565666921, 33836.830815845766, 34113.658863411045, 34707.65292347044, 34938.12654683551, 39790.40314395229, 43457.78271108751, 43569.128617428105, 43680.78159609309, 44222.557774423134, 10559.607307120576, 10608.204384671335, 10680.252382333161, 10690.144788416752, 11131.053860421955, 11730.413479326171, 11772.234804737665, 11897.0, 12011.939940300243, 12148.696282593006, 10650.680479585624, 10950.233483656068, 11037.668869933916, 11128.1653875958, 11149.888501114885, 10705.304155229886, 11275.210735248455, 11277.830832537355, 11302.4913878874, 11453.942730286295, 10782.514786834454, 10787.946060269649, 10826.242163048511, 10873.07578855806, 10925.344479331265, 8924.286057115285, 8962.68630597926, 9016.143466370946, 9110.863337050083, 9360.95319523398, 8255.298299644597, 8665.277423804167, 8933.419327743675, 9098.135677110664, 9179.91493785259], "unit": "score", "name": "yui.html", "value": 6320.129525090291}], "name": "dromaeo_css", "value": 6903.668528828256}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 111.0, 112.0, 110.0, 123.0, 110.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 155.0, 170.0, 129.0, 158.0, 165.0, 130.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 163.0, 162.0, 162.0, 162.0, 164.0, 165.0, 169.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 75.0, 80.0, 76.0, 75.0, 76.0, 79.0, 149.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 142.0, 93.0, 93.0, 94.0, 142.0, 93.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 119.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 63.0, 63.0, 59.0, 58.0, 61.0, 58.0, 64.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 85.0, 85.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [121.0, 119.0, 114.0, 123.0, 130.0, 118.0, 115.0, 123.0, 118.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [134.0, 145.0, 144.0, 142.0, 146.0, 137.0, 144.0, 144.0, 145.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.4}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 72.0, 69.0, 69.0, 68.0, 69.0, 71.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1517.0}]} 11:25:06 INFO - Return code: 0 11:25:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:25:06 ERROR - # TBPL SUCCESS # 11:25:06 INFO - Running post-action listener: _resource_record_post_action 11:25:06 INFO - Running post-run listener: _resource_record_post_run 11:25:07 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 531599360; Read time: 396; Write time: 1606476 11:25:07 INFO - install - Wall time: 16s; CPU: 21.0%; Read bytes: 0; Write bytes: 241049600; Read time: 0; Write time: 1158928 11:25:07 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290394112; Read time: 396; Write time: 447448 11:25:07 INFO - Running post-run listener: _upload_blobber_files 11:25:07 INFO - Blob upload gear active. 11:25:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:25:07 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 11:25:07 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'] 11:25:07 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 11:25:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:25:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:25:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:08 INFO - (blobuploader) - INFO - Done attempting. 11:25:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:25:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:25:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:09 INFO - (blobuploader) - INFO - Done attempting. 11:25:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:25:09 INFO - Return code: 0 11:25:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:25:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:25:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8444c9d9c86db50accddfcf91f01d3ca9f17380e3da66bbd7321adef188018c9975f363c1912d9bd6d46ddf73ee1f28a2abcced710ba146e53fb87340ad8d423", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702d7d3860b0ce229fc0b49249cfbf49a89faa346dcd8d9aa7dee57133d77bbc697a96d9df3d8072c0fc7284cf1dd9f43f29b0292bd6d9626f077ca0799c17bd"} 11:25:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:25:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:25:09 INFO - Contents: 11:25:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8444c9d9c86db50accddfcf91f01d3ca9f17380e3da66bbd7321adef188018c9975f363c1912d9bd6d46ddf73ee1f28a2abcced710ba146e53fb87340ad8d423", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702d7d3860b0ce229fc0b49249cfbf49a89faa346dcd8d9aa7dee57133d77bbc697a96d9df3d8072c0fc7284cf1dd9f43f29b0292bd6d9626f077ca0799c17bd"} 11:25:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:25:09 INFO - Copying logs to upload dir... 11:25:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:25:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.947194 ========= master_lag: 0.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-10 11:25:10.017752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 11:25:10.021025) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 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/8444c9d9c86db50accddfcf91f01d3ca9f17380e3da66bbd7321adef188018c9975f363c1912d9bd6d46ddf73ee1f28a2abcced710ba146e53fb87340ad8d423", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702d7d3860b0ce229fc0b49249cfbf49a89faa346dcd8d9aa7dee57133d77bbc697a96d9df3d8072c0fc7284cf1dd9f43f29b0292bd6d9626f077ca0799c17bd"} build_url:https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/DgqBEhCyQoGiVPFJ5GWl4A/artifacts/public/build/firefox-48.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/8444c9d9c86db50accddfcf91f01d3ca9f17380e3da66bbd7321adef188018c9975f363c1912d9bd6d46ddf73ee1f28a2abcced710ba146e53fb87340ad8d423", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/702d7d3860b0ce229fc0b49249cfbf49a89faa346dcd8d9aa7dee57133d77bbc697a96d9df3d8072c0fc7284cf1dd9f43f29b0292bd6d9626f077ca0799c17bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 11:25:10.046326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:25:10.046668) ========= 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=af724c981e2a0f424dbabf99000001e7-1457634632.428174-2054542613 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 11:25:10.096501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 11:25:10.096830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 11:25:10.097122) ========= ========= Total master_lag: 0.90 =========