builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1459285186.81 results: success (0) buildid: 20160329113202 builduid: 315750d447474016b7248c4b1391f69b revision: 7720685c0eba1b49380b66419c48ecbf7d1a60d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.815245) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.815851) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.816176) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006131 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.839468) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.839778) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.865719) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.866252) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019764 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.916395) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.916697) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.917067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:46.917362) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-29 13:59:47-- 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% 7.17M=0.002s 2016-03-29 13:59:47 (7.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.040574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.040889) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083117 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.135743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.136092) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7720685c0eba1b49380b66419c48ecbf7d1a60d5 --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 7720685c0eba1b49380b66419c48ecbf7d1a60d5 --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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-29 13:59:47,287 truncating revision to first 12 chars 2016-03-29 13:59:47,287 Setting DEBUG logging. 2016-03-29 13:59:47,287 attempt 1/10 2016-03-29 13:59:47,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7720685c0eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 13:59:47,532 unpacking tar archive at: fx-team-7720685c0eba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.654165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.654548) ========= echo 7720685c0eba1b49380b66419c48ecbf7d1a60d5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7720685c0eba1b49380b66419c48ecbf7d1a60d5'] 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7720685c0eba1b49380b66419c48ecbf7d1a60d5 program finished with exit code 0 elapsedTime=0.003941 script_repo_revision: '7720685c0eba1b49380b66419c48ecbf7d1a60d5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.703996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.704319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 13:59:47.714331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-29 13:59:47.714696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:59:47 INFO - MultiFileLogger online at 20160329 13:59:47 in /builds/slave/test-pgo 13:59:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:59:47 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:59:47 INFO - {'append_to_log': False, 13:59:47 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:59:47 INFO - 'blob_upload_branch': 'Fx-Team', 13:59:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:59:47 INFO - 'branch': 'Fx-Team', 13:59:47 INFO - 'buildbot_json_path': 'buildprops.json', 13:59:47 INFO - 'config_files': ('talos/linux_config.py',), 13:59:47 INFO - 'default_actions': ('clobber', 13:59:47 INFO - 'read-buildbot-config', 13:59:47 INFO - 'download-and-extract', 13:59:47 INFO - 'populate-webroot', 13:59:47 INFO - 'create-virtualenv', 13:59:47 INFO - 'install', 13:59:47 INFO - 'run-tests'), 13:59:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:59:47 INFO - 'download_minidump_stackwalk': True, 13:59:47 INFO - 'download_symbols': 'ondemand', 13:59:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:59:47 INFO - 'tooltool.py': '/tools/tooltool.py', 13:59:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:59:47 INFO - '/tools/misc-python/virtualenv.py')}, 13:59:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:59:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:59:47 INFO - 'installer_path': 'installer.exe', 13:59:47 INFO - 'log_level': 'info', 13:59:47 INFO - 'log_name': 'talos', 13:59:47 INFO - 'log_to_console': True, 13:59:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:59:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:59:47 INFO - 'opt_config_files': (), 13:59:47 INFO - 'pip_index': False, 13:59:47 INFO - 'sps_profile': False, 13:59:47 INFO - 'sps_profile_interval': 0, 13:59:47 INFO - 'suite': 'dromaeojs', 13:59:47 INFO - 'system_bits': '32', 13:59:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:59:47 INFO - 'title': 'talos-linux64-ix-015', 13:59:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:59:47 INFO - 'use_talos_json': True, 13:59:47 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:59:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:59:47 INFO - 'work_dir': 'build'} 13:59:47 INFO - ##### 13:59:47 INFO - ##### Running clobber step. 13:59:47 INFO - ##### 13:59:47 INFO - Running pre-action listener: _resource_record_pre_action 13:59:47 INFO - Running main action method: clobber 13:59:47 INFO - rmtree: /builds/slave/test-pgo/build 13:59:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:59:53 INFO - Running post-action listener: _resource_record_post_action 13:59:53 INFO - ##### 13:59:53 INFO - ##### Running read-buildbot-config step. 13:59:53 INFO - ##### 13:59:53 INFO - Running pre-action listener: _resource_record_pre_action 13:59:53 INFO - Running main action method: read_buildbot_config 13:59:53 INFO - Using buildbot properties: 13:59:53 INFO - { 13:59:53 INFO - "project": "", 13:59:53 INFO - "product": "firefox", 13:59:53 INFO - "script_repo_revision": "production", 13:59:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:59:53 INFO - "repository": "", 13:59:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:59:53 INFO - "buildid": "20160329113202", 13:59:53 INFO - "pgo_build": "True", 13:59:53 INFO - "basedir": "/builds/slave/test-pgo", 13:59:53 INFO - "buildnumber": 565, 13:59:53 INFO - "slavename": "talos-linux64-ix-015", 13:59:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:59:53 INFO - "platform": "ubuntu64_hw", 13:59:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:59:53 INFO - "branch": "fx-team", 13:59:53 INFO - "repo_path": "integration/fx-team", 13:59:53 INFO - "revision": "7720685c0eba1b49380b66419c48ecbf7d1a60d5", 13:59:53 INFO - "stage_platform": "linux64-pgo", 13:59:53 INFO - "builduid": "315750d447474016b7248c4b1391f69b", 13:59:53 INFO - "slavebuilddir": "test" 13:59:53 INFO - } 13:59:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:59:53 INFO - Running post-action listener: _resource_record_post_action 13:59:53 INFO - ##### 13:59:53 INFO - ##### Running download-and-extract step. 13:59:53 INFO - ##### 13:59:53 INFO - Running pre-action listener: _resource_record_pre_action 13:59:53 INFO - Running main action method: download_and_extract 13:59:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:59:53 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')]} 13:59:53 INFO - https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 13:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 13:59:53 INFO - Downloaded 1361 bytes. 13:59:53 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:59:53 INFO - Using the following test package requirements: 13:59:53 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:59:53 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:59:53 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:59:53 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'jsshell-linux-x86_64.zip'], 13:59:53 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:59:53 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:59:53 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:59:53 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:59:53 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:59:53 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:59:53 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:59:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:59:53 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')]} 13:59:53 INFO - https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:59:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:59:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:59:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 13:59:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:00:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip: timed out 14:00:23 INFO - retry: attempt #1 caught exception: timed out 14:00:23 INFO - retry: Failed, sleeping 30 seconds before retrying 14:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 #2 14:00:55 INFO - Downloaded 23673566 bytes. 14:00:55 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'] 14:00:55 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 14:00:56 INFO - Return code: 0 14:00:56 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 14:00:56 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')]} 14:00:56 INFO - https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:00:58 INFO - Downloaded 23673566 bytes. 14:00:58 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'] 14:00:58 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 14:01:00 INFO - Return code: 0 14:01:00 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')]} 14:01:00 INFO - https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:01:03 INFO - Downloaded 10847531 bytes. 14:01:03 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'] 14:01:03 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 14:01:03 INFO - Return code: 0 14:01:03 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')]} 14:01:03 INFO - https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/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 14:01:06 INFO - Downloaded 57744250 bytes. 14:01:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:06 INFO - mkdir: /builds/slave/test-pgo/properties 14:01:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:01:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:01:06 INFO - Contents: 14:01:06 INFO - build_url:https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:01:07 INFO - Running post-action listener: _resource_record_post_action 14:01:07 INFO - Running post-action listener: set_extra_try_arguments 14:01:07 INFO - ##### 14:01:07 INFO - ##### Running populate-webroot step. 14:01:07 INFO - ##### 14:01:07 INFO - Running pre-action listener: _resource_record_pre_action 14:01:07 INFO - Running main action method: populate_webroot 14:01:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:07 INFO - '--tppagecycles', 14:01:07 INFO - '7'], 14:01:07 INFO - 'tests': ['tsvgm']}}, 14:01:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:01:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:01:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'tests': ['damp', 'tps']}, 14:01:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['damp', 'tps']}, 14:01:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:01:07 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['dromaeo_dom']}, 14:01:07 INFO - 'other': {'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'other_l64': {'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'other_nol64': {'tests': ['a11yr', 14:01:07 INFO - 'ts_paint', 14:01:07 INFO - 'tpaint', 14:01:07 INFO - 'sessionrestore', 14:01:07 INFO - 'sessionrestore_no_auto_restore', 14:01:07 INFO - 'tabpaint']}, 14:01:07 INFO - 'svgr': {'tests': ['tsvgx', 14:01:07 INFO - 'tsvgr_opacity', 14:01:07 INFO - 'tart', 14:01:07 INFO - 'tscrollx', 14:01:07 INFO - 'cart']}, 14:01:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['tsvgx', 14:01:07 INFO - 'tsvgr_opacity', 14:01:07 INFO - 'tart', 14:01:07 INFO - 'tscrollx', 14:01:07 INFO - 'cart']}, 14:01:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'tests': ['tp5o']}, 14:01:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'talos_options': ['--e10s'], 14:01:07 INFO - 'tests': ['tp5o']}, 14:01:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'talos_options': ['--xperf_path', 14:01:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:07 INFO - 'tests': ['tp5n']}, 14:01:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:01:07 INFO - 'talos_options': ['--e10s', 14:01:07 INFO - '--xperf_path', 14:01:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:07 INFO - 'tests': ['tp5n']}}, 14:01:07 INFO - 'talos.zip': {'path': '', 14:01:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:07 INFO - Running post-action listener: _resource_record_post_action 14:01:07 INFO - ##### 14:01:07 INFO - ##### Running create-virtualenv step. 14:01:07 INFO - ##### 14:01:07 INFO - Running pre-action listener: _resource_record_pre_action 14:01:07 INFO - Running main action method: create_virtualenv 14:01:07 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:01:07 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 14:01:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:01:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:07 INFO - Using real prefix '/usr' 14:01:07 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:01:07 INFO - Installing distribute.............................................................................................................................................................................................done. 14:01:09 INFO - Installing pip.................done. 14:01:09 INFO - Return code: 0 14:01:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:09 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:09 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 14:01:09 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 14:01:09 INFO - Using env: {'DISPLAY': ':0', 14:01:09 INFO - 'HOME': '/home/cltbld', 14:01:09 INFO - 'LANG': 'en_US.UTF-8', 14:01:09 INFO - 'LANGUAGE': 'en_US:en', 14:01:09 INFO - 'LOGNAME': 'cltbld', 14:01:09 INFO - 'MAIL': '/var/mail/cltbld', 14:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:09 INFO - 'MOZ_NO_REMOTE': '1', 14:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:09 INFO - 'NO_EM_RESTART': '1', 14:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:09 INFO - 'SHELL': '/bin/bash', 14:01:09 INFO - 'SHLVL': '1', 14:01:09 INFO - 'TERM': 'linux', 14:01:09 INFO - 'TMOUT': '86400', 14:01:09 INFO - 'USER': 'cltbld', 14:01:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:09 INFO - '_': '/tools/buildbot/bin/python'} 14:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:10 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 14:01:10 INFO - Cleaning up... 14:01:10 INFO - Return code: 0 14:01:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:01:10 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')]} 14:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:10 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')]} 14:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:10 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:10 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 14:01:10 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 14:01:10 INFO - Using env: {'DISPLAY': ':0', 14:01:10 INFO - 'HOME': '/home/cltbld', 14:01:10 INFO - 'LANG': 'en_US.UTF-8', 14:01:10 INFO - 'LANGUAGE': 'en_US:en', 14:01:10 INFO - 'LOGNAME': 'cltbld', 14:01:10 INFO - 'MAIL': '/var/mail/cltbld', 14:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:10 INFO - 'MOZ_NO_REMOTE': '1', 14:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:10 INFO - 'NO_EM_RESTART': '1', 14:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:10 INFO - 'SHELL': '/bin/bash', 14:01:10 INFO - 'SHLVL': '1', 14:01:10 INFO - 'TERM': 'linux', 14:01:10 INFO - 'TMOUT': '86400', 14:01:10 INFO - 'USER': 'cltbld', 14:01:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:10 INFO - '_': '/tools/buildbot/bin/python'} 14:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:10 INFO - Downloading/unpacking psutil>=0.7.1 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:12 INFO - Installing collected packages: psutil 14:01:12 INFO - Running setup.py install for psutil 14:01:12 INFO - building 'psutil._psutil_linux' extension 14:01:12 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 14:01:12 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 14:01:12 INFO - building 'psutil._psutil_posix' extension 14:01:12 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 14:01:12 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 14:01:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:01:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:01:12 INFO - Successfully installed psutil 14:01:12 INFO - Cleaning up... 14:01:12 INFO - Return code: 0 14:01:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:01:12 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')]} 14:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 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')]} 14:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:12 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:12 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 14:01:12 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 14:01:12 INFO - Using env: {'DISPLAY': ':0', 14:01:12 INFO - 'HOME': '/home/cltbld', 14:01:12 INFO - 'LANG': 'en_US.UTF-8', 14:01:12 INFO - 'LANGUAGE': 'en_US:en', 14:01:12 INFO - 'LOGNAME': 'cltbld', 14:01:12 INFO - 'MAIL': '/var/mail/cltbld', 14:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:12 INFO - 'MOZ_NO_REMOTE': '1', 14:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:12 INFO - 'NO_EM_RESTART': '1', 14:01:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:12 INFO - 'SHELL': '/bin/bash', 14:01:12 INFO - 'SHLVL': '1', 14:01:12 INFO - 'TERM': 'linux', 14:01:12 INFO - 'TMOUT': '86400', 14:01:12 INFO - 'USER': 'cltbld', 14:01:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:12 INFO - '_': '/tools/buildbot/bin/python'} 14:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01: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 14:01:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:01:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:01:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:01:14 INFO - Installing collected packages: mozsystemmonitor 14:01:14 INFO - Running setup.py install for mozsystemmonitor 14:01:15 INFO - Successfully installed mozsystemmonitor 14:01:15 INFO - Cleaning up... 14:01:15 INFO - Return code: 0 14:01:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:15 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:15 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 14:01:15 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 14:01:15 INFO - Using env: {'DISPLAY': ':0', 14:01:15 INFO - 'HOME': '/home/cltbld', 14:01:15 INFO - 'LANG': 'en_US.UTF-8', 14:01:15 INFO - 'LANGUAGE': 'en_US:en', 14:01:15 INFO - 'LOGNAME': 'cltbld', 14:01:15 INFO - 'MAIL': '/var/mail/cltbld', 14:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:15 INFO - 'MOZ_NO_REMOTE': '1', 14:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:15 INFO - 'NO_EM_RESTART': '1', 14:01:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:15 INFO - 'SHELL': '/bin/bash', 14:01:15 INFO - 'SHLVL': '1', 14:01:15 INFO - 'TERM': 'linux', 14:01:15 INFO - 'TMOUT': '86400', 14:01:15 INFO - 'USER': 'cltbld', 14:01:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:15 INFO - '_': '/tools/buildbot/bin/python'} 14:01:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:15 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 14:01:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:01:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:01:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 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 14:01:17 INFO - Downloading docopt-0.6.1.tar.gz 14:01:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:01:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:01:17 INFO - Running setup.py install for blobuploader 14:01:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:01:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:01:17 INFO - Running setup.py install for requests 14:01:18 INFO - Running setup.py install for docopt 14:01:18 INFO - Successfully installed blobuploader requests docopt 14:01:18 INFO - Cleaning up... 14:01:18 INFO - Return code: 0 14:01:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:18 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')]} 14:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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')]} 14:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:18 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:18 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 14:01:18 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 14:01:18 INFO - Using env: {'DISPLAY': ':0', 14:01:18 INFO - 'HOME': '/home/cltbld', 14:01:18 INFO - 'LANG': 'en_US.UTF-8', 14:01:18 INFO - 'LANGUAGE': 'en_US:en', 14:01:18 INFO - 'LOGNAME': 'cltbld', 14:01:18 INFO - 'MAIL': '/var/mail/cltbld', 14:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:18 INFO - 'MOZ_NO_REMOTE': '1', 14:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:18 INFO - 'NO_EM_RESTART': '1', 14:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:18 INFO - 'SHELL': '/bin/bash', 14:01:18 INFO - 'SHLVL': '1', 14:01:18 INFO - 'TERM': 'linux', 14:01:18 INFO - 'TMOUT': '86400', 14:01:18 INFO - 'USER': 'cltbld', 14:01:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:18 INFO - '_': '/tools/buildbot/bin/python'} 14:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:18 INFO - Running setup.py (path:/tmp/pip-nVsIj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:18 INFO - Running setup.py (path:/tmp/pip-CPlAq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:18 INFO - Running setup.py (path:/tmp/pip-p7fKND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:18 INFO - Running setup.py (path:/tmp/pip-o3VBnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:18 INFO - Running setup.py (path:/tmp/pip-x_IOWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:19 INFO - Running setup.py (path:/tmp/pip-RKpf_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:19 INFO - Running setup.py (path:/tmp/pip-7bPUE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:19 INFO - Running setup.py (path:/tmp/pip-HwdFzY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:19 INFO - Running setup.py (path:/tmp/pip-7KRdvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:19 INFO - Running setup.py (path:/tmp/pip-PUXKr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:19 INFO - Running setup.py (path:/tmp/pip-D1zX1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:19 INFO - Running setup.py (path:/tmp/pip-qukD7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:19 INFO - Running setup.py (path:/tmp/pip-Cpmri9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:19 INFO - Running setup.py (path:/tmp/pip-5QMSus-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:19 INFO - Running setup.py (path:/tmp/pip-_qJthM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:19 INFO - Running setup.py (path:/tmp/pip-3bdbSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:19 INFO - Running setup.py (path:/tmp/pip-03bt5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:01:19 INFO - Running setup.py install for manifestparser 14:01:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:01:19 INFO - Running setup.py install for mozcrash 14:01:20 INFO - Running setup.py install for mozdebug 14:01:20 INFO - Running setup.py install for mozdevice 14:01:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Running setup.py install for mozfile 14:01:20 INFO - Running setup.py install for mozhttpd 14:01:20 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Running setup.py install for mozinfo 14:01:20 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Running setup.py install for mozInstall 14:01:20 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Running setup.py install for mozleak 14:01:20 INFO - Running setup.py install for mozlog 14:01:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:01:20 INFO - Running setup.py install for moznetwork 14:01:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Running setup.py install for mozprocess 14:01:21 INFO - Running setup.py install for mozprofile 14:01:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Running setup.py install for mozrunner 14:01:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Running setup.py install for mozscreenshot 14:01:21 INFO - Running setup.py install for moztest 14:01:21 INFO - Running setup.py install for mozversion 14:01:21 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:01:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:01:21 INFO - Cleaning up... 14:01:21 INFO - Return code: 0 14:01:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:21 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:21 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 14:01:21 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 14:01:21 INFO - Using env: {'DISPLAY': ':0', 14:01:21 INFO - 'HOME': '/home/cltbld', 14:01:21 INFO - 'LANG': 'en_US.UTF-8', 14:01:21 INFO - 'LANGUAGE': 'en_US:en', 14:01:21 INFO - 'LOGNAME': 'cltbld', 14:01:21 INFO - 'MAIL': '/var/mail/cltbld', 14:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:21 INFO - 'MOZ_NO_REMOTE': '1', 14:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:21 INFO - 'NO_EM_RESTART': '1', 14:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:21 INFO - 'SHELL': '/bin/bash', 14:01:21 INFO - 'SHLVL': '1', 14:01:21 INFO - 'TERM': 'linux', 14:01:21 INFO - 'TMOUT': '86400', 14:01:21 INFO - 'USER': 'cltbld', 14:01:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:21 INFO - '_': '/tools/buildbot/bin/python'} 14:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:21 INFO - Running setup.py (path:/tmp/pip-f7x5nC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:01:21 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)) 14:01:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:21 INFO - Running setup.py (path:/tmp/pip-Bi_F_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:22 INFO - Running setup.py (path:/tmp/pip-83Rg1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:22 INFO - Running setup.py (path:/tmp/pip-iX1AnN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:22 INFO - Running setup.py (path:/tmp/pip-qqg8Xp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:22 INFO - Running setup.py (path:/tmp/pip-b4Gixt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:22 INFO - Running setup.py (path:/tmp/pip-mSAZVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:22 INFO - Running setup.py (path:/tmp/pip-nfzCnU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:22 INFO - Running setup.py (path:/tmp/pip-rZtrrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:22 INFO - Running setup.py (path:/tmp/pip-biJV0I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:22 INFO - Running setup.py (path:/tmp/pip-sbtcyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:22 INFO - Running setup.py (path:/tmp/pip-OzebvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:22 INFO - Running setup.py (path:/tmp/pip-hacz3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:22 INFO - Running setup.py (path:/tmp/pip-R_Iura-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:22 INFO - Running setup.py (path:/tmp/pip-A02jJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:01:22 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)) 14:01:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:22 INFO - Running setup.py (path:/tmp/pip-j_4_BV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:01:23 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)) 14:01:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:23 INFO - Running setup.py (path:/tmp/pip-Cwnwjx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:01:23 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)) 14:01:23 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)) 14:01:23 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)) 14:01:23 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)) 14:01:23 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)) 14:01:23 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)) 14:01:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:01:23 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 14:01:23 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 14:01:23 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 14:01:23 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 14:01:23 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 14:01:23 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 14:01:24 INFO - Downloading blessings-1.6.tar.gz 14:01:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:01:25 INFO - Installing collected packages: blessings 14:01:25 INFO - Running setup.py install for blessings 14:01:25 INFO - Successfully installed blessings 14:01:25 INFO - Cleaning up... 14:01:25 INFO - Return code: 0 14:01:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:01:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:25 INFO - Reading from file tmpfile_stdout 14:01:25 INFO - Current package versions: 14:01:25 INFO - argparse == 1.2.1 14:01:25 INFO - blessings == 1.6 14:01:25 INFO - blobuploader == 1.2.4 14:01:25 INFO - docopt == 0.6.1 14:01:25 INFO - manifestparser == 1.1 14:01:25 INFO - mozInstall == 1.12 14:01:25 INFO - mozcrash == 0.17 14:01:25 INFO - mozdebug == 0.1 14:01:25 INFO - mozdevice == 0.48 14:01:25 INFO - mozfile == 1.2 14:01:25 INFO - mozhttpd == 0.7 14:01:25 INFO - mozinfo == 0.9 14:01:25 INFO - mozleak == 0.1 14:01:25 INFO - mozlog == 3.1 14:01:25 INFO - moznetwork == 0.27 14:01:25 INFO - mozprocess == 0.22 14:01:25 INFO - mozprofile == 0.28 14:01:25 INFO - mozrunner == 6.11 14:01:25 INFO - mozscreenshot == 0.1 14:01:25 INFO - mozsystemmonitor == 0.0 14:01:25 INFO - moztest == 0.7 14:01:25 INFO - mozversion == 1.4 14:01:25 INFO - psutil == 3.1.1 14:01:25 INFO - requests == 1.2.3 14:01:25 INFO - wsgiref == 0.1.2 14:01:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:01:25 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')]} 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 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')]} 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:25 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 14:01:25 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 14:01:25 INFO - Using env: {'DISPLAY': ':0', 14:01:25 INFO - 'HOME': '/home/cltbld', 14:01:25 INFO - 'LANG': 'en_US.UTF-8', 14:01:25 INFO - 'LANGUAGE': 'en_US:en', 14:01:25 INFO - 'LOGNAME': 'cltbld', 14:01:25 INFO - 'MAIL': '/var/mail/cltbld', 14:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:25 INFO - 'MOZ_NO_REMOTE': '1', 14:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:25 INFO - 'NO_EM_RESTART': '1', 14:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:25 INFO - 'SHELL': '/bin/bash', 14:01:25 INFO - 'SHLVL': '1', 14:01:25 INFO - 'TERM': 'linux', 14:01:25 INFO - 'TMOUT': '86400', 14:01:25 INFO - 'USER': 'cltbld', 14:01:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:25 INFO - '_': '/tools/buildbot/bin/python'} 14:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 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)) 14:01:25 INFO - Cleaning up... 14:01:25 INFO - Return code: 0 14:01:25 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:01:25 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')]} 14:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 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')]} 14:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:25 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:25 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 14:01:25 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 14:01:25 INFO - Using env: {'DISPLAY': ':0', 14:01:25 INFO - 'HOME': '/home/cltbld', 14:01:25 INFO - 'LANG': 'en_US.UTF-8', 14:01:25 INFO - 'LANGUAGE': 'en_US:en', 14:01:25 INFO - 'LOGNAME': 'cltbld', 14:01:25 INFO - 'MAIL': '/var/mail/cltbld', 14:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:25 INFO - 'MOZ_NO_REMOTE': '1', 14:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:25 INFO - 'NO_EM_RESTART': '1', 14:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:25 INFO - 'SHELL': '/bin/bash', 14:01:25 INFO - 'SHLVL': '1', 14:01:25 INFO - 'TERM': 'linux', 14:01:25 INFO - 'TMOUT': '86400', 14:01:25 INFO - 'USER': 'cltbld', 14:01:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:25 INFO - '_': '/tools/buildbot/bin/python'} 14:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:25 INFO - Downloading/unpacking jsonschema 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:25 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 14:01:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:01:27 INFO - Downloading/unpacking functools32 (from jsonschema) 14:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:01:27 INFO - Downloading functools32-3.2.3-2.tar.gz 14:01:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:01:27 INFO - warning: no files found matching '*.txt' 14:01:27 INFO - no previously-included directories found matching 'build' 14:01:27 INFO - no previously-included directories found matching 'dist' 14:01:27 INFO - no previously-included directories found matching '.git*' 14:01:27 INFO - Installing collected packages: jsonschema, functools32 14:01:28 INFO - Running setup.py install for functools32 14:01:28 INFO - warning: no files found matching '*.txt' 14:01:28 INFO - no previously-included directories found matching 'build' 14:01:28 INFO - no previously-included directories found matching 'dist' 14:01:28 INFO - no previously-included directories found matching '.git*' 14:01:28 INFO - Successfully installed jsonschema functools32 14:01:28 INFO - Cleaning up... 14:01:28 INFO - Return code: 0 14:01:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:01:28 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')]} 14:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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')]} 14:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:01:28 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 0x7fc3849ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f346b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, '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': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', '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 14:01:28 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 14:01:28 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 14:01:28 INFO - Using env: {'DISPLAY': ':0', 14:01:28 INFO - 'HOME': '/home/cltbld', 14:01:28 INFO - 'LANG': 'en_US.UTF-8', 14:01:28 INFO - 'LANGUAGE': 'en_US:en', 14:01:28 INFO - 'LOGNAME': 'cltbld', 14:01:28 INFO - 'MAIL': '/var/mail/cltbld', 14:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:28 INFO - 'MOZ_NO_REMOTE': '1', 14:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:28 INFO - 'NO_EM_RESTART': '1', 14:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:28 INFO - 'SHELL': '/bin/bash', 14:01:28 INFO - 'SHLVL': '1', 14:01:28 INFO - 'TERM': 'linux', 14:01:28 INFO - 'TMOUT': '86400', 14:01:28 INFO - 'USER': 'cltbld', 14:01:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:28 INFO - '_': '/tools/buildbot/bin/python'} 14:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:01:28 INFO - Downloading/unpacking flake8 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:28 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 14:01:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:01:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:01:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 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 14:01:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:01:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:30 INFO - no previously-included directories found matching 'docs/_build' 14:01:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:01:31 INFO - Running setup.py install for pep8 14:01:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:01:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:01:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:01:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:01:31 INFO - no previously-included directories found matching 'docs/_build' 14:01:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:01:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:01:31 INFO - Cleaning up... 14:01:31 INFO - Return code: 0 14:01:31 INFO - Running post-action listener: _resource_record_post_action 14:01:31 INFO - Running post-action listener: _start_resource_monitoring 14:01:31 INFO - Starting resource monitoring. 14:01:31 INFO - ##### 14:01:31 INFO - ##### Running install step. 14:01:31 INFO - ##### 14:01:31 INFO - Running pre-action listener: _resource_record_pre_action 14:01:31 INFO - Running main action method: install 14:01:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:01:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:01:31 INFO - Reading from file tmpfile_stdout 14:01:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:01:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:01:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:01:31 INFO - Reading from file tmpfile_stdout 14:01:31 INFO - Output received: 14:01:31 INFO - Usage: mozinstall [options] installer 14:01:31 INFO - Options: 14:01:31 INFO - -h, --help show this help message and exit 14:01:31 INFO - -d DEST, --destination=DEST 14:01:31 INFO - Directory to install application into. [default: 14:01:31 INFO - "/builds/slave/test-pgo"] 14:01:31 INFO - --app=APP Application being installed. [default: firefox] 14:01:31 INFO - mkdir: /builds/slave/test-pgo/build/application 14:01:31 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'] 14:01:31 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 14:01:47 INFO - Reading from file tmpfile_stdout 14:01:47 INFO - Output received: 14:01:47 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:01:47 INFO - Running post-action listener: _resource_record_post_action 14:01:47 INFO - ##### 14:01:47 INFO - ##### Running run-tests step. 14:01:47 INFO - ##### 14:01:47 INFO - Running pre-action listener: _resource_record_pre_action 14:01:47 INFO - Running main action method: run_tests 14:01:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:01:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:01:47 INFO - Python 2.7.3 14:01:47 INFO - Return code: 0 14:01:47 INFO - grabbing minidump binary from tooltool 14:01:47 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')]} 14:01:47 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 0x1f2f1d0>, '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 0x1f32750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f32be0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:01:47 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 14:01:47 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 14:01:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:48 INFO - Return code: 0 14:01:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:01:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:01:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:01:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:01:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:01:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:01:49 INFO - Return code: 0 14:01:49 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:01:49 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:01:49 INFO - Using env: {'DISPLAY': ':0', 14:01:49 INFO - 'HOME': '/home/cltbld', 14:01:49 INFO - 'LANG': 'en_US.UTF-8', 14:01:49 INFO - 'LANGUAGE': 'en_US:en', 14:01:49 INFO - 'LOGNAME': 'cltbld', 14:01:49 INFO - 'MAIL': '/var/mail/cltbld', 14:01:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:49 INFO - 'MOZ_NO_REMOTE': '1', 14:01:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:49 INFO - 'NO_EM_RESTART': '1', 14:01:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:01:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:01:49 INFO - 'SHELL': '/bin/bash', 14:01:49 INFO - 'SHLVL': '1', 14:01:49 INFO - 'TERM': 'linux', 14:01:49 INFO - 'TMOUT': '86400', 14:01:49 INFO - 'USER': 'cltbld', 14:01:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120', 14:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:49 INFO - '_': '/tools/buildbot/bin/python'} 14:01:49 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:01:49 INFO - mozversion application_buildid: 20160329113202 14:01:49 INFO - mozversion application_changeset: 7720685c0eba1b49380b66419c48ecbf7d1a60d5 14:01:49 INFO - mozversion application_display_name: Nightly 14:01:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:49 INFO - mozversion application_name: Firefox 14:01:49 INFO - mozversion application_remotingname: firefox 14:01:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:01:49 INFO - mozversion application_vendor: Mozilla 14:01:49 INFO - mozversion application_version: 48.0a1 14:01:49 INFO - mozversion platform_buildid: 20160329113202 14:01:49 INFO - mozversion platform_changeset: 7720685c0eba1b49380b66419c48ecbf7d1a60d5 14:01:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:01:49 INFO - mozversion platform_version: 48.0a1 14:01:49 INFO - using testdate: 1459285309 14:01:49 INFO - actual date: 1459285309 14:01:49 INFO - starting webserver on 'localhost:60901' 14:01:49 INFO - SUITE-START | Running 2 tests 14:01:49 INFO - TEST-START | dromaeo_css 14:01:49 INFO - operating with platform_type : linux_ 14:01:49 INFO - Initialising browser for dromaeo_css test... 14:01:49 INFO - TEST-INFO | started process 12264 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFHwXvj/profile http://localhost:60901/getInfo.html) 14:01:53 INFO - PROCESS | 12264 | __metrics Screen width/height:1600/1200 14:01:53 INFO - PROCESS | 12264 | colorDepth:24 14:01:53 INFO - PROCESS | 12264 | Browser inner width/height: 1024/697 14:01:53 INFO - PROCESS | 12264 | __metrics 14:01:54 ERROR - PROCESS | 12264 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:01:54 INFO - PROCESS | 12264 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:01:54 INFO - TEST-INFO | 12264: exit 0 14:01:54 INFO - Browser initialized. 14:01:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:54 INFO - TEST-INFO | started process 12360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFHwXvj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:06 INFO - PROCESS | 12360 | RSS: Main: 153092096 14:02:06 INFO - PROCESS | 12360 | 14:02:57 INFO - PROCESS | 12360 | 1459285377379 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] 14:05:04 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60901/tests/dromaeo/cssquery-ext.html) 14:05:05 INFO - PROCESS | 12360 | RSS: Main: 244523008 14:05:05 INFO - PROCESS | 12360 | 14:08:07 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-ext.html (next: http://localhost:60901/tests/dromaeo/cssquery-jquery.html) 14:08:08 INFO - PROCESS | 12360 | RSS: Main: 231923712 14:08:08 INFO - PROCESS | 12360 | 14:11:10 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60901/tests/dromaeo/cssquery-mootools.html) 14:11:10 INFO - PROCESS | 12360 | RSS: Main: 241672192 14:11:10 INFO - PROCESS | 12360 | 14:14:12 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60901/tests/dromaeo/cssquery-prototype.html) 14:14:13 INFO - PROCESS | 12360 | RSS: Main: 221032448 14:14:13 INFO - PROCESS | 12360 | 14:17:15 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60901/tests/dromaeo/cssquery-yui.html) 14:17:16 INFO - PROCESS | 12360 | RSS: Main: 220635136 14:17:16 INFO - PROCESS | 12360 | 14:20:18 INFO - PROCESS | 12360 | Cycle 1(1): loaded http://localhost:60901/tests/dromaeo/cssquery-yui.html (next: http://localhost:60901/tests/dromaeo/cssquery-dojo.html) 14:20:19 INFO - PROCESS | 12360 | RSS: Main: 259481600 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | __start_tp_report 14:20:19 INFO - PROCESS | 12360 | _x_x_mozilla_page_load 14:20:19 INFO - PROCESS | 12360 | _x_x_mozilla_page_load_details 14:20:19 INFO - PROCESS | 12360 | |i|pagename|runs| 14:20:19 INFO - PROCESS | 12360 | |0;dojo.html;3040.832754198518;3071.20148761322;3072.1398008557603;3080.0605815226345;3106.968930310697;5143.125668636331;5185.688858668478;5200.115980283352;5218.29553010344;5253.763580638871;5215.921761173586;5219.86950326242;5226.320578324822;5300.602454815895;5302.602304827144;4690.296455531663;4720.15037293288;4778.378810754597;4796.97601511992;4850.4179498460235;4660.836870709526;4757.405324334458;4795.520447955211;4801.231802911535;4817.325574419584;4683.742394168319;4739.170645137087;4742.9525704742855;4768.070226305872;4792.664513484057;4772.379590653228;4782.784774685148;4782.976085119587;4789.521047895182;4821.349117869077;4643.489216186217;4717.103750287469;4743.95256047442;4756.661309842645;4808.63935204861;5078.64449488536;5094.923576146323;5108.055009823158;5129.717865517395;5140.3060586820675;5526.253955716007;5527.226188333637;5528.778848846041;5531.1426728857095;5569.192467092289;5409.5672346212605;5535.474129957647;5597.356304025048;5609.915851262234;5665;5244.160934250502;5259.579233661298;5261.605379596507;5264.341957255343;5291.708956007418;5708.257926469615;5709.885802283931;5710.486056254957;5711.514521265656;5713.371529131792;5335.359756829205;5423.511883930465;5493.121100623881;5495.065838807413;5497.890042199214;5610.831675049755;5628.971855140698;5629.802956896489;5633.746481408347;5636.85907852307;5589.636673616202;5606.60753747242;5621.747021384048;5622.6345287557;5623.550115990711;5447.972760136174;5545.417731138173;5596.244506991586;5622.746976386073;5649.774009039675;4230.767307798039;4236.724612900213;4237.216115018731;4241.363795430649;4273.658107351404;3737.1965027518672;3799.886003419902;3808.143167787281;3839.9040023999623;3855.614438556122;5260.184671375943;5298.602604804655;5339.279197308391;5347.652402593819;5350.678959262456;5492.917606235909;5542.057850165482;5544.362398324244;5547.805826796042;5549.250851135126;5200.817971370984;5211.2443695663915;5216.634835561475;5220.791168353299;5258.92111618326;4486.775661216926;4492.326151077365;4532.297493888453;4574.725516469022;4582.633389328846;5739.081746920473;5784.479396854304;5788.7684492620665;5789.450002249864;5794.971025144931;5422.322209723785;5568.303962004749;5605.887882242414;5610.691411972381;5660.886782264414;5664.745086471201;5717.42825717425;5735.512481439125;5740.0815869460685;5759.625624334405;5535.363433205233;5571.860703482445;5572.387037425961;5577.525910297508;5579.860503487445;5520.309961254843;5615.354234263112;5647.7176141193595;5649.519790817662;5651.15232715096;5460.699661518495;5512.39363670004;5512.834614961557;5549.112142057252;5567.832965011056;5341.412444631165;5387.138057910715;5392.946070539401;5393.757280922289;5400.567954563704;5281.762320695655;5326.2276969838385;5328.49379308965;5353.759080841293;5379.973100134474;5501.944980550144;5512.862178445571;5519.3652729936575;5524.696141712084;5572.192032155233;5378.623496355218;5382.838514844561;5384.353877534721;5390.460953904578;5436.048691478896 14:20:19 INFO - PROCESS | 12360 | |1;ext.html;564.1776571935101;574.9453801888819;577.6274303074517;595.3391735173956;657.4575974820774;30714.38571228574;39743.80128099359;39863.60136398635;39901.60098399015;40027.399589006185;41867.58132418675;42387.788061059655;42495.15009699812;42552.78723606385;42580.36129458061;7951.483153595027;8636.13638636136;8805.69180078694;8826.205641492264;10098.141657959046;10304.330218535808;10445.58217671296;10446.791064178711;10449.477526123701;10450.738731531697;10421.583136674524;10540.262181647287;10548.841767373495;10549.314294570866;10561.260711750181;10367.118794902442;10466.633667821628;10474.42390668513;10475.528601212925;10476.947615261952;10205.132563732092;10343.224258180666;10348.741281467948;10352.223583231287;10638.946805266001;42557;42970.78514607407;42996.57003429957;43001.1399772006;43053.354199687026;3600.891973240807;3642.1440961374055;4110.486189226347;4243.830246790125;4269.573042695737;32524.512132318036;32964.6703532964;33000.3399932;33101.834490827634;33329.6667033329;4183.226103170923;4280.5291417944;4314.223439780838;4318.719283246579;4375.8249670013165;328416;328815;329277.3536132328;329818;330176;58251;58493.70753146207;58495.415045849;58512;58524.707376462844;68342.65828670825;68569.65715171491;68601.31398685949;68610.65694671495;68663.31336686669;15713.450029248921;17028.233729482203;17158.914205428893;17163;17190.828091719173;12492.81260781089;12560.81158782619;12562.05784566143;12575;12580.81128783069;20396;20861.58276834455;20934.162633494794;20970.685439718418;21001.89499052495;7210.134783825974;7515.248475152551;7709.884351734729;7724.227577242231;7812.882806757903;1101.0472404069428;1110.0675432636624;1121.725177331559;1191.8450601421932;1204.175140029083;32979;33086.66913330836;33118.50322245168;33399.4990075149;33838.83080584581;1085.2132204151926;1203.3983008495752;1263.6145975477384;1289.1684863263142;1311.1477539599337;17074.48776536706;17085.316587336616;17090.40183593568;17113.743293850603;17116.74324885128;403415;405890;411783;411837;412176;59794.70102649546;59983.700081499315;60115.09827352593;60122.39877601168;60236;1296.2157894473896;1310.33173081729;1396.4763213794827;1419.2407062221869;1435.798988141661;30930.226744331572;31753.20616984594;32855.342893141526;33024.50463243102;33042;48607.75696121497;49246;49724.50275497344;49806.750966246385;49829.25256121089;310954;317531;318155;318610;318933;39398.80300598479;47322;47414.52585474101;47461;48490;46051;46286.768566156956;46760.7661961688;47840;47875.52124478711;39176.62220054995;39740.205195896495;43386.38598172389;43721.12557748891;44203.33694994642;42211.577884221995;42425.36361954635;43034.56965430306;44063.55936440595;44118;43181.13637727291;43609.781951090044;44027.33958990554;44235.55764442314;44270.11459770851;37557.81221093877;38564.42153367758;38812.223755524166;39152.80423597864;39233.803830980665;29399.534430273936;29924.55113173348;30102.548461773527;30178.2455438607;30197.547036794025 14:20:19 INFO - PROCESS | 12360 | |2;jquery.html;378.07749092214993;380.35339922132374;380.57755890961045;386.8916703323069;389.41976455081937;17459.912700436496;18067.81932180678;18727.15727792249;18755.15601797919;18770.81229187708;13664.521741739041;17083.145842707876;17715.114244287797;17731.29074837005;17752.733708994376;5007.449180590123;5202.115640341132;5235.869103272411;5236.764345604457;5238.345206849144;3865.7100717446165;5410.48600382963;5623.409541998092;5639.15412688096;5642.463965923231;5626.352969408509;5627.8593035174035;5628;5641.717914104299;5646.520045796112;5761.395053519383;6142.600730952474;6157.2919114301985;6182.196314479112;6188.350223226564;5474.91787623186;5483.369412517572;5484.122540393518;5489.176623506466;5499.697516636584;13243.73512529744;13595.52415665447;13597.86402135976;13601.047926645138;13626.523071692542;2175.7497887742798;2684.81206315558;2849.230707708907;2983.1498023063323;3012.171652795477;5957.553183511254;10190.643327483576;10428.113610343129;10438.947805261001;11234.269772464846;1885.4626431467104;1964.4597735622676;1983.9702404463944;2038.908249128778;2091.895405229732;65778;66313.3368666312;69297.65351173263;69316.30683693099;70707;10136.847947280796;10375;10585.465107559361;10636.149108071335;10677.78644427107;14297.571072867831;14301.28493575338;14364.856351436352;14443.927780361031;14447.133172009713;7945.642446089824;8157.592120393957;8199.631016604268;8241.79395515105;8262.586870656443;7900.525968441912;7992.5204487730925;8035.437519373588;8060.395470339748;8130.634121464548;4433.756143412079;4559.224931761609;4562.270036794097;4571.839985600554;4613.469451013109;1756.2360373237682;1765.1819535765903;1826.6620675175136;1839.9908000459911;1895.4976931113265;957.8084383123403;1038.924712922122;1063.4948399510172;1096.0760477490564;1116.7152376144193;17599.20803563843;17676.11619419024;17944.19251133702;18011.72982405265;18291.81708182928;1006.4313662780505;1009.1623952119724;1035.140833108518;1035.6530562261726;1084.8481212630238;10105.848412273821;10250.436226007641;10480.895191048145;10544;10746.462676866126;376891;382106;384009;386309;502125;82725;86507.56746216229;88187.55906220428;88302;88748;1044.8171569975225;1074.4681382715605;1090.738222826516;1096.8848270931596;1116.8268918317674;16457.341706331612;16551.66896662084;16583.419580315112;16726.247318870923;17017.06406147624;36510.8174459126;36692.266154677294;37165.81417092897;37663.81168094142;38260.23479530338;50499;53949.46050539445;54542.18186727282;55618.44381556295;56144.157837631654;8271.751847444586;8367.246947774729;8388.370872184489;8570.48577085377;8701.8694719578;9579.473128977974;12312.753744924872;12652.620421387373;12695.238285702888;13188;5777.133429985536;7392.96303518479;10197.9490102549;11466.82799758021;11865.347405892759;11394.37330946806;11501.827472588086;11554.537818487503;11829.408529573315;11847.822282665595;6099.054646529795;8228.724547695118;9636.46999415011;10306.381617102998;11618.244814087057;8337.583120844054;8436.789080273042;8450.957745211235;8613.784655383415;8733.08302628215;10720.946395267974;11549.711257218301;11713.355765432983;11879.287242765462;12118.394080296126 14:20:19 INFO - PROCESS | 12360 | |3;mootools.html;1349.7165595225001;1458.9051711638742;1461.7588097963837;1651.7439796831488;1837.0171958002463;7785.338246249068;7968.402369822257;7992.640331185096;7999.600019998991;8033.397495187855;7879.4484386093;8081.797955051126;8093.109757926623;8125.715599954003;8129.5528745918955;2104.8737075775425;2298.712660917385;2399.448126930807;2430.513897220554;2467.592847180213;2429.8056155507516;2443.841150325232;2444.1079006162713;2445.1686426614947;2445.9388515287083;2346.1905642553293;2432.781049705526;2434.793042591373;2437.366284765965;2437.8415402998835;2377;2396.892139853711;2416.8791560421996;2419.5040016796515;2424.5635785558593;2385.85684858909;2394.2697477269426;2411.2525117213545;2447.645091461728;2464.913728019511;8064.758057258292;8149.633266503021;8154.776783482465;8164.306033987118;8173.182681731839;5115.897682046376;5248.21276808478;5266.078436273637;5284.682919024871;5286.867828304285;3343.9498407523906;3420.110771199481;3572.8749493767596;3580.1765593913547;3581.767185132958;1132.1904838040841;1138.681169272605;1139.3164101539094;1160.5705888821105;1175.864775550814;11616.59341923037;11642.76714465706;11647.534098636044;11655.59205427806;11657.009154221902;4585.70192937458;4625.4911959684405;4692.788824502905;4727.7163370197895;4728.1252968201;9782.364146330467;9782.853257201148;9784.706458806248;9795.755106122404;9826.508674566243;4647;5144.176931690987;5144.871378215575;5156.871078223075;5160.045391602491;4502.549745025472;4574.130915126116;4626.028534007896;4627.722336659811;4636.304554316812;3873.6901047916663;3960.5841386653988;3977.4033894915992;3996.3805610130476;4034.9798251008556;1267.2649863079391;1292.2956988441322;1292.6315999939973;1293.3985696651102;1308.784050631654;1392.5335012770634;1397.5667543061684;1407.507372419645;1438.2305466575333;1441.5963530211557;7995.440319177718;8005.199480051948;8052.677892884336;8059.395545334123;8059.476134051268;502.2817371159204;504.5383474121138;509.93370861788475;510.1684254664947;518.4271380124983;6202.596831205957;6240.344763799736;6258.624482531062;6320.589161704566;6328.6202827830475;9991.300608957448;10279.794404111875;10293.948530257301;10300.433476158883;10310.278280520291;9485.573149208301;9935.503224838729;10001.299909006446;10036.64871729486;10069.69790906274;7620.1998790127345;7687.461877668621;7695.730649427243;7718.845623087507;7723.884141737878;7674.117476490275;7694.653740581575;7748.186440423674;7765.844683106419;7781.688732450639;8607.311415086904;8876.556172191236;8951.239144672776;8974.102589740975;8976.461412315282;8940.955295223483;9030.729078127666;9183.357164998653;9238.445693258425;9290.303227257848;6366.522510811615;6566.737330506918;7034.366906978396;7046.612436315847;7182.174049984319;7833.686652533835;7850.921490785019;7927.16764739694;7937.166597507178;7942.920570794218;6948.374646281859;7144.464165187528;7173.641317934187;7191.460640451883;7305.671244794104;7039.331263529956;7057.752978645723;7091.60996145217;7105.46708996817;7149.428045756431;7238.312360325761;7377.114746230487;7382.483226174117;7391.926080739124;7406.962965185139;6850.143732033496;6863.794086177422;6882.070920425678;6885.621290828852;6906.171259448898;6952.130983627047;6969.58182509051;7041.5422997505;7054.08296921397;7060.188078371053 14:20:19 INFO - PROCESS | 12360 | |4;prototype.html;350.3308680420396;350.5679300059258;354.2136457065315;356.1559104921336;359.62419271860887;6032.366601506845;6033.487153591945;6041.939580604193;6051.878962420749;6059.333473317932;5995.520358371331;5997.850053748648;5998.010328295826;6009.308929473112;6014.097885317205;4454.57681520255;4508.174189453261;4604.700694454867;4636.5595268449615;4664.043871006435;4607.884802879921;4613.746243956581;4623.075384923012;4631.814727410916;4635.8841028974375;4588.24293991491;4594.035252596958;4597.632189424855;4603.585677289043;4609.492955774879;4401.031773009932;4512.007358381151;4616.146012987608;4623.768811559442;4636.536346365337;4081.734687245349;4098.877033688994;4108.281050816096;4108.712390132692;4113.341865301538;5790.7973220937065;5791.247137872092;5791.942080579224;5793.65238085712;5794.246747922785;5372.328458942632;5390.0836857734275;5390.1914712793005;5392.056390131711;5393.19102134679;6300.842478938063;6323.146375239376;6325.588836725644;6329.873402531924;6330.620162790201;4307.8492252771;4388;4390.692651514395;4422.911541769179;4542.863714088583;6566.376194261537;6580.045893345438;6626.072349871022;6627.271000189975;6637.93362066378;4529.071540334224;4534.501204867462;4542.227821270392;4543.091381723602;4543.977280113579;4592.15045216636;4596.402467679247;4599.218132917412;4601.976990115028;4605.286180642006;5285.762140703678;5292.497212764782;5293.973530132324;5297.973510132425;5309.973450132725;6212;6398.9040164397575;6405.29541750407;6408.295087540367;6436.967815160894;1596.9441069562743;1602.7675986982056;1614.3946020242408;1617.3126421270913;1624.6750649870073;1012.422918936214;1035.1873779083535;1039.8440233964966;1081.1296905990596;1090.3022065877844;6028.276606807123;6038.426349496791;6053.243344581927;6092.573519853657;6104.755809767648;6502.804915852532;6504.609723416515;6506.674666266667;6514.120593719882;6521.184851893513;6062.787802426894;6089.2997305310455;6094.542909281821;6099.359567245464;6099.542534309856;3484.738644601665;3514.5431093957623;3518.2787528556582;3522.9823850881094;3523.207278362348;6641.402273795382;6691.698873550702;6850.691718872663;6851.2806155353965;6872.41584465316;6725.529212955144;6753.12209412783;6819.659017049128;6826.829329266709;6834.1457317835275;6836.282190370039;6852.109225800714;6853.451723862079;6855.143107111611;6857.691403886937;6662.200535935719;6720.092787473628;6726.764563240263;6737.494687898526;6739.359760822714;6443.677816109082;6485.383888530582;6572.967135164294;6575.342465753386;6579.6313327203125;6786.778379891667;6833.453323734188;6833.89749153773;6834.179898412222;6836.726530938906;4521.2087884619405;4522.773861306987;4533.387992620954;4537;4543.7955292011275;6611.801645950629;6621.735130594722;6625.734970601315;6631.336866313523;6640.07039014548;6343.061199359685;6402.487800975818;6446.387593178828;6456.903146452713;6480.027995800668;6398.872022559616;6426.325235850169;6428.228612566522;6435.388638079375;6441.066045423481;6288.0882272069375;6298.244210694746;6308.52686048539;6325.96837015812;6327.936720632919;6484.448821850196;6517.4460170886005;6541.967290163519;6545.14913061299;6545.37818907203;6017.699115044318;6107.480864126599;6210.937890621036;6240.564670125806;6303 14:20:19 INFO - PROCESS | 12360 | |5;yui.html;752.6575408189275;758.2455456820464;858.3390789092399;859.9269062129719;870.6299822575404;13981.231032293219;14073.507427240049;14113.929430352846;14116.788248176286;14119.223442710647;14178.645533861658;14252.572422827332;14255.71488570228;14276.214808185545;14282.4287028519;669.1267895396505;817.284875733733;836.1847198981005;839.5676226743202;839.911809260028;816.3713940265992;826.9669213231464;828.1635548096406;829.266099501939;832.8084540555676;710.4955481608039;867.7657032601194;872.0799556467924;873.6680061576624;875.995620021899;707.5188871567332;713.4185638704439;861.1775754154799;873.2402809555728;875.4528419737663;613.3529126771255;616.2143267334185;619.9938000619982;620.1287191495956;621.5369549685513;14156.504522341771;14181;14217.146971181763;14241.287935603283;14267.357968891321;13634.386452609657;13793.655158621015;13815.240161791098;13822.101563398448;13939.581812545639;11062.336259824437;11277;11762.411879406081;12101.455434505468;12342;3855.8843234703004;3859.8842034738723;3919.3533067043904;3931.4495970564144;3966.7421617594764;54308.18537721937;54805.45194548043;54822.451775482135;54848.725756370965;54871.72564137154;10929.945350273198;11280.379579123228;11449.370284634426;11545.942270288595;11866.88133118675;20401.89799050995;20719.896400518202;20738.896305518676;20743.170273189204;20743.58512829765;8525.829483410296;8541.103184165697;8618.138186181332;8741.781455463537;9020.413673111227;4776;4917.680350777188;4953.72754498506;4965.131102057126;5059.418166910778;3364.6467120951947;3384;3404.9489257661153;3413.992872102736;3414.0270023043313;588.5232961301359;628.8335138318354;632.2413104274889;648.4293821437105;654.4633400611453;693.9444844412435;760.3347071312602;767.8963339949147;776.8601651702635;796.80079980005;9016.63933442668;9143.954280228556;9654.903450965541;9735.069600359284;9829.223331362353;722.9493935424575;728.1989811207735;743.4461326311824;756.4666909828558;759;4442.244818380883;4475.48531918827;4479.910401792011;4652.744099074515;4750.334953106568;52831.471685283424;53474.7326263374;64782;65348.67325663436;65370;54739.17891231635;55578.72210638921;56148;56354;56437;49642;49730;49945.50054499409;50438.74780626073;50516.49483505191;9527.76180595463;9623.374480658735;9648.807023859343;9714;9850.374688176371;37876;37957.810210948766;38841.6115838838;38959.6104038956;39423.40864887086;44743.77628111969;49648.751756240985;49906;50350.496495036045;50915.2362714567;11651.184417090722;12086.576969806014;12208.023358131506;12298.385080746106;12337.568185113478;12086.335251560897;12357.75284494287;12435.156145488072;12518.749625007267;12775.488980440678;9992.300538962203;12500.310891138142;12772.233665980071;12914.418851151908;13896.86103138996;12060.757423941352;12861.807072893727;13320.800187997382;13351.933240334125;13504.122232055279;12248;12343.950764184785;12618.495260189857;13016.544420945222;13866.445342186604;11086;11102.2783519071;11245.943770281096;11325.603603873826;11554.480048397674;10480.475976201007;11127.72180695489;11588.536458541565;11629.302241865515;11927.880721193023 14:20:19 INFO - PROCESS | 12360 | __end_tp_report 14:20:19 INFO - PROCESS | 12360 | __start_cc_report 14:20:19 INFO - PROCESS | 12360 | _x_x_mozilla_cycle_collect,785 14:20:19 INFO - PROCESS | 12360 | __end_cc_report 14:20:19 INFO - PROCESS | 12360 | __startTimestamp1459286419200__endTimestamp 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | ------- Summary: start ------- 14:20:19 INFO - PROCESS | 12360 | Number of tests: 6 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#0] dojo.html Cycles:165 Average:5177.55 Median:5379.97 stddev:588.93 (10.9%) stddev-sans-first:566.38 14:20:19 INFO - PROCESS | 12360 | Values: 3040.8 3071.2 3072.1 3080.1 3107.0 5143.1 5185.7 5200.1 5218.3 5253.8 5215.9 5219.9 5226.3 5300.6 5302.6 4690.3 4720.2 4778.4 4797.0 4850.4 4660.8 4757.4 4795.5 4801.2 4817.3 4683.7 4739.2 4743.0 4768.1 4792.7 4772.4 4782.8 4783.0 4789.5 4821.3 4643.5 4717.1 4744.0 4756.7 4808.6 5078.6 5094.9 5108.1 5129.7 5140.3 5526.3 5527.2 5528.8 5531.1 5569.2 5409.6 5535.5 5597.4 5609.9 5665.0 5244.2 5259.6 5261.6 5264.3 5291.7 5708.3 5709.9 5710.5 5711.5 5713.4 5335.4 5423.5 5493.1 5495.1 5497.9 5610.8 5629.0 5629.8 5633.7 5636.9 5589.6 5606.6 5621.7 5622.6 5623.6 5448.0 5545.4 5596.2 5622.7 5649.8 4230.8 4236.7 4237.2 4241.4 4273.7 3737.2 3799.9 3808.1 3839.9 3855.6 5260.2 5298.6 5339.3 5347.7 5350.7 5492.9 5542.1 5544.4 5547.8 5549.3 5200.8 5211.2 5216.6 5220.8 5258.9 4486.8 4492.3 4532.3 4574.7 4582.6 5739.1 5784.5 5788.8 5789.5 5795.0 5422.3 5568.3 5605.9 5610.7 5660.9 5664.7 5717.4 5735.5 5740.1 5759.6 5535.4 5571.9 5572.4 5577.5 5579.9 5520.3 5615.4 5647.7 5649.5 5651.2 5460.7 5512.4 5512.8 5549.1 5567.8 5341.4 5387.1 5392.9 5393.8 5400.6 5281.8 5326.2 5328.5 5353.8 5380.0 5501.9 5512.9 5519.4 5524.7 5572.2 5378.6 5382.8 5384.4 5390.5 5436.0 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#1] ext.html Cycles:180 Average:53957.13 Median:38688.32 stddev:92741.13 (239.7%) stddev-sans-first:92914.65 14:20:19 INFO - PROCESS | 12360 | Values: 564.2 574.9 577.6 595.3 657.5 30714.4 39743.8 39863.6 39901.6 40027.4 41867.6 42387.8 42495.2 42552.8 42580.4 7951.5 8636.1 8805.7 8826.2 10098.1 10304.3 10445.6 10446.8 10449.5 10450.7 10421.6 10540.3 10548.8 10549.3 10561.3 10367.1 10466.6 10474.4 10475.5 10476.9 10205.1 10343.2 10348.7 10352.2 10638.9 42557.0 42970.8 42996.6 43001.1 43053.4 3600.9 3642.1 4110.5 4243.8 4269.6 32524.5 32964.7 33000.3 33101.8 33329.7 4183.2 4280.5 4314.2 4318.7 4375.8 328416.0 328815.0 329277.4 329818.0 330176.0 58251.0 58493.7 58495.4 58512.0 58524.7 68342.7 68569.7 68601.3 68610.7 68663.3 15713.5 17028.2 17158.9 17163.0 17190.8 12492.8 12560.8 12562.1 12575.0 12580.8 20396.0 20861.6 20934.2 20970.7 21001.9 7210.1 7515.2 7709.9 7724.2 7812.9 1101.0 1110.1 1121.7 1191.8 1204.2 32979.0 33086.7 33118.5 33399.5 33838.8 1085.2 1203.4 1263.6 1289.2 1311.1 17074.5 17085.3 17090.4 17113.7 17116.7 403415.0 405890.0 411783.0 411837.0 412176.0 59794.7 59983.7 60115.1 60122.4 60236.0 1296.2 1310.3 1396.5 1419.2 1435.8 30930.2 31753.2 32855.3 33024.5 33042.0 48607.8 49246.0 49724.5 49806.8 49829.3 310954.0 317531.0 318155.0 318610.0 318933.0 39398.8 47322.0 47414.5 47461.0 48490.0 46051.0 46286.8 46760.8 47840.0 47875.5 39176.6 39740.2 43386.4 43721.1 44203.3 42211.6 42425.4 43034.6 44063.6 44118.0 43181.1 43609.8 44027.3 44235.6 44270.1 37557.8 38564.4 38812.2 39152.8 39233.8 29399.5 29924.6 30102.5 30178.2 30197.5 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#2] jquery.html Cycles:180 Average:25286.67 Median:2997.66 stddev:67661.35 (2257.1%) stddev-sans-first:67825.31 14:20:19 INFO - PROCESS | 12360 | Values: 378.1 380.4 380.6 386.9 389.4 17459.9 18067.8 18727.2 18755.2 18770.8 13664.5 17083.1 17715.1 17731.3 17752.7 5007.4 5202.1 5235.9 5236.8 5238.3 3865.7 5410.5 5623.4 5639.2 5642.5 5626.4 5627.9 5628.0 5641.7 5646.5 5761.4 6142.6 6157.3 6182.2 6188.4 5474.9 5483.4 5484.1 5489.2 5499.7 13243.7 13595.5 13597.9 13601.0 13626.5 2175.7 2684.8 2849.2 2983.1 3012.2 5957.6 10190.6 10428.1 10438.9 11234.3 1885.5 1964.5 1984.0 2038.9 2091.9 65778.0 66313.3 69297.7 69316.3 70707.0 10136.8 10375.0 10585.5 10636.1 10677.8 14297.6 14301.3 14364.9 14443.9 14447.1 7945.6 8157.6 8199.6 8241.8 8262.6 7900.5 7992.5 8035.4 8060.4 8130.6 4433.8 4559.2 4562.3 4571.8 4613.5 1756.2 1765.2 1826.7 1840.0 1895.5 957.8 1038.9 1063.5 1096.1 1116.7 17599.2 17676.1 17944.2 18011.7 18291.8 1006.4 1009.2 1035.1 1035.7 1084.8 10105.8 10250.4 10480.9 10544.0 10746.5 376891.0 382106.0 384009.0 386309.0 502125.0 82725.0 86507.6 88187.6 88302.0 88748.0 1044.8 1074.5 1090.7 1096.9 1116.8 16457.3 16551.7 16583.4 16726.2 17017.1 36510.8 36692.3 37165.8 37663.8 38260.2 50499.0 53949.5 54542.2 55618.4 56144.2 8271.8 8367.2 8388.4 8570.5 8701.9 9579.5 12312.8 12652.6 12695.2 13188.0 5777.1 7393.0 10197.9 11466.8 11865.3 11394.4 11501.8 11554.5 11829.4 11847.8 6099.1 8228.7 9636.5 10306.4 11618.2 8337.6 8436.8 8451.0 8613.8 8733.1 10720.9 11549.7 11713.4 11879.3 12118.4 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#3] mootools.html Cycles:180 Average:5796.65 Median:5285.78 stddev:3019.94 (57.1%) stddev-sans-first:3009.91 14:20:19 INFO - PROCESS | 12360 | Values: 1349.7 1458.9 1461.8 1651.7 1837.0 7785.3 7968.4 7992.6 7999.6 8033.4 7879.4 8081.8 8093.1 8125.7 8129.6 2104.9 2298.7 2399.4 2430.5 2467.6 2429.8 2443.8 2444.1 2445.2 2445.9 2346.2 2432.8 2434.8 2437.4 2437.8 2377.0 2396.9 2416.9 2419.5 2424.6 2385.9 2394.3 2411.3 2447.6 2464.9 8064.8 8149.6 8154.8 8164.3 8173.2 5115.9 5248.2 5266.1 5284.7 5286.9 3343.9 3420.1 3572.9 3580.2 3581.8 1132.2 1138.7 1139.3 1160.6 1175.9 11616.6 11642.8 11647.5 11655.6 11657.0 4585.7 4625.5 4692.8 4727.7 4728.1 9782.4 9782.9 9784.7 9795.8 9826.5 4647.0 5144.2 5144.9 5156.9 5160.0 4502.5 4574.1 4626.0 4627.7 4636.3 3873.7 3960.6 3977.4 3996.4 4035.0 1267.3 1292.3 1292.6 1293.4 1308.8 1392.5 1397.6 1407.5 1438.2 1441.6 7995.4 8005.2 8052.7 8059.4 8059.5 502.3 504.5 509.9 510.2 518.4 6202.6 6240.3 6258.6 6320.6 6328.6 9991.3 10279.8 10293.9 10300.4 10310.3 9485.6 9935.5 10001.3 10036.6 10069.7 7620.2 7687.5 7695.7 7718.8 7723.9 7674.1 7694.7 7748.2 7765.8 7781.7 8607.3 8876.6 8951.2 8974.1 8976.5 8941.0 9030.7 9183.4 9238.4 9290.3 6366.5 6566.7 7034.4 7046.6 7182.2 7833.7 7850.9 7927.2 7937.2 7942.9 6948.4 7144.5 7173.6 7191.5 7305.7 7039.3 7057.8 7091.6 7105.5 7149.4 7238.3 7377.1 7382.5 7391.9 7407.0 6850.1 6863.8 6882.1 6885.6 6906.2 6952.1 6969.6 7041.5 7054.1 7060.2 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#4] prototype.html Cycles:180 Average:5348.33 Median:6046.91 stddev:1614.67 (26.7%) stddev-sans-first:1575.01 14:20:19 INFO - PROCESS | 12360 | Values: 350.3 350.6 354.2 356.2 359.6 6032.4 6033.5 6041.9 6051.9 6059.3 5995.5 5997.9 5998.0 6009.3 6014.1 4454.6 4508.2 4604.7 4636.6 4664.0 4607.9 4613.7 4623.1 4631.8 4635.9 4588.2 4594.0 4597.6 4603.6 4609.5 4401.0 4512.0 4616.1 4623.8 4636.5 4081.7 4098.9 4108.3 4108.7 4113.3 5790.8 5791.2 5791.9 5793.7 5794.2 5372.3 5390.1 5390.2 5392.1 5393.2 6300.8 6323.1 6325.6 6329.9 6330.6 4307.8 4388.0 4390.7 4422.9 4542.9 6566.4 6580.0 6626.1 6627.3 6637.9 4529.1 4534.5 4542.2 4543.1 4544.0 4592.2 4596.4 4599.2 4602.0 4605.3 5285.8 5292.5 5294.0 5298.0 5310.0 6212.0 6398.9 6405.3 6408.3 6437.0 1596.9 1602.8 1614.4 1617.3 1624.7 1012.4 1035.2 1039.8 1081.1 1090.3 6028.3 6038.4 6053.2 6092.6 6104.8 6502.8 6504.6 6506.7 6514.1 6521.2 6062.8 6089.3 6094.5 6099.4 6099.5 3484.7 3514.5 3518.3 3523.0 3523.2 6641.4 6691.7 6850.7 6851.3 6872.4 6725.5 6753.1 6819.7 6826.8 6834.1 6836.3 6852.1 6853.5 6855.1 6857.7 6662.2 6720.1 6726.8 6737.5 6739.4 6443.7 6485.4 6573.0 6575.3 6579.6 6786.8 6833.5 6833.9 6834.2 6836.7 4521.2 4522.8 4533.4 4537.0 4543.8 6611.8 6621.7 6625.7 6631.3 6640.1 6343.1 6402.5 6446.4 6456.9 6480.0 6398.9 6426.3 6428.2 6435.4 6441.1 6288.1 6298.2 6308.5 6326.0 6327.9 6484.4 6517.4 6542.0 6545.1 6545.4 6017.7 6107.5 6210.9 6240.6 6303.0 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - PROCESS | 12360 | [#5] yui.html Cycles:180 Average:15159.93 Median:4846.84 stddev:17374.11 (358.5%) stddev-sans-first:17389.16 14:20:19 INFO - PROCESS | 12360 | Values: 752.7 758.2 858.3 859.9 870.6 13981.2 14073.5 14113.9 14116.8 14119.2 14178.6 14252.6 14255.7 14276.2 14282.4 669.1 817.3 836.2 839.6 839.9 816.4 827.0 828.2 829.3 832.8 710.5 867.8 872.1 873.7 876.0 707.5 713.4 861.2 873.2 875.5 613.4 616.2 620.0 620.1 621.5 14156.5 14181.0 14217.1 14241.3 14267.4 13634.4 13793.7 13815.2 13822.1 13939.6 11062.3 11277.0 11762.4 12101.5 12342.0 3855.9 3859.9 3919.4 3931.4 3966.7 54308.2 54805.5 54822.5 54848.7 54871.7 10929.9 11280.4 11449.4 11545.9 11866.9 20401.9 20719.9 20738.9 20743.2 20743.6 8525.8 8541.1 8618.1 8741.8 9020.4 4776.0 4917.7 4953.7 4965.1 5059.4 3364.6 3384.0 3404.9 3414.0 3414.0 588.5 628.8 632.2 648.4 654.5 693.9 760.3 767.9 776.9 796.8 9016.6 9144.0 9654.9 9735.1 9829.2 722.9 728.2 743.4 756.5 759.0 4442.2 4475.5 4479.9 4652.7 4750.3 52831.5 53474.7 64782.0 65348.7 65370.0 54739.2 55578.7 56148.0 56354.0 56437.0 49642.0 49730.0 49945.5 50438.7 50516.5 9527.8 9623.4 9648.8 9714.0 9850.4 37876.0 37957.8 38841.6 38959.6 39423.4 44743.8 49648.8 49906.0 50350.5 50915.2 11651.2 12086.6 12208.0 12298.4 12337.6 12086.3 12357.8 12435.2 12518.7 12775.5 9992.3 12500.3 12772.2 12914.4 13896.9 12060.8 12861.8 13320.8 13351.9 13504.1 12248.0 12344.0 12618.5 13016.5 13866.4 11086.0 11102.3 11245.9 11325.6 11554.5 10480.5 11127.7 11588.5 11629.3 11927.9 14:20:19 INFO - PROCESS | 12360 | -------- Summary: end -------- 14:20:19 INFO - PROCESS | 12360 | 14:20:19 INFO - TEST-INFO | 12360: exit 0 14:20:19 INFO - TEST-OK | dromaeo_css | took 1110631ms 14:20:19 INFO - TEST-START | kraken 14:20:19 INFO - operating with platform_type : linux_ 14:20:19 INFO - Initialising browser for kraken test... 14:20:19 INFO - TEST-INFO | started process 12554 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCqcqo1/profile http://localhost:60901/getInfo.html) 14:20:24 INFO - PROCESS | 12554 | __metrics Screen width/height:1600/1200 14:20:24 INFO - PROCESS | 12554 | colorDepth:24 14:20:24 INFO - PROCESS | 12554 | Browser inner width/height: 1024/697 14:20:24 INFO - PROCESS | 12554 | __metrics 14:20:24 ERROR - PROCESS | 12554 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:20:25 INFO - TEST-INFO | 12554: exit 0 14:20:25 INFO - Browser initialized. 14:20:25 INFO - Running cycle 1/1 for kraken test... 14:20:25 INFO - TEST-INFO | started process 12641 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCqcqo1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:37 INFO - PROCESS | 12641 | RSS: Main: 153694208 14:20:37 INFO - PROCESS | 12641 | 14:20:39 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60901/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:40 INFO - PROCESS | 12641 | RSS: Main: 194887680 14:20:40 INFO - PROCESS | 12641 | 14:20:43 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60901/tests/kraken/driver.html?testName=audio-dft) 14:20:43 INFO - PROCESS | 12641 | RSS: Main: 185679872 14:20:43 INFO - PROCESS | 12641 | 14:20:46 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60901/tests/kraken/driver.html?testName=audio-fft) 14:20:47 INFO - PROCESS | 12641 | RSS: Main: 169414656 14:20:47 INFO - PROCESS | 12641 | 14:20:49 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60901/tests/kraken/driver.html?testName=audio-oscillator) 14:20:49 INFO - PROCESS | 12641 | RSS: Main: 171618304 14:20:49 INFO - PROCESS | 12641 | 14:20:52 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:52 INFO - PROCESS | 12641 | RSS: Main: 172908544 14:20:52 INFO - PROCESS | 12641 | 14:20:55 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60901/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:56 INFO - PROCESS | 12641 | RSS: Main: 173060096 14:20:56 INFO - PROCESS | 12641 | 14:20:59 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60901/tests/kraken/driver.html?testName=imaging-desaturate) 14:21:00 INFO - PROCESS | 12641 | RSS: Main: 173109248 14:21:00 INFO - PROCESS | 12641 | 14:21:02 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60901/tests/kraken/driver.html?testName=json-parse-financial) 14:21:03 INFO - PROCESS | 12641 | RSS: Main: 173805568 14:21:03 INFO - PROCESS | 12641 | 14:21:05 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:21:05 INFO - PROCESS | 12641 | RSS: Main: 184541184 14:21:05 INFO - PROCESS | 12641 | 14:21:07 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:21:07 INFO - PROCESS | 12641 | RSS: Main: 181407744 14:21:07 INFO - PROCESS | 12641 | 14:21:09 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:21:10 INFO - PROCESS | 12641 | RSS: Main: 195514368 14:21:10 INFO - PROCESS | 12641 | 14:21:12 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:21:13 INFO - PROCESS | 12641 | RSS: Main: 200753152 14:21:13 INFO - PROCESS | 12641 | 14:21:16 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:21:16 INFO - PROCESS | 12641 | RSS: Main: 200040448 14:21:16 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | Cycle 1(1): loaded http://localhost:60901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60901/tests/kraken/driver.html?testName=ai-astar) 14:21:18 INFO - PROCESS | 12641 | RSS: Main: 261521408 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | __start_tp_report 14:21:18 INFO - PROCESS | 12641 | _x_x_mozilla_page_load 14:21:18 INFO - PROCESS | 12641 | _x_x_mozilla_page_load_details 14:21:18 INFO - PROCESS | 12641 | |i|pagename|runs| 14:21:18 INFO - PROCESS | 12641 | |0;ai-astar;110;110;103;110;110;110;97;108;109;107 14:21:18 INFO - PROCESS | 12641 | |1;audio-beat-detection;161;128;157;167;127;166;152;127;174;124 14:21:18 INFO - PROCESS | 12641 | |2;audio-dft;162;161;162;161;161;160;159;163;161;162 14:21:18 INFO - PROCESS | 12641 | |3;audio-fft;76;77;105;101;75;73;75;121;109;74 14:21:18 INFO - PROCESS | 12641 | |4;audio-oscillator;98;93;141;92;93;93;140;93;92;143 14:21:18 INFO - PROCESS | 12641 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;116 14:21:18 INFO - PROCESS | 12641 | |6;imaging-darkroom;146;147;146;146;147;146;147;147;146;146 14:21:18 INFO - PROCESS | 12641 | |7;imaging-desaturate;96;95;95;96;96;96;96;96;96;96 14:21:18 INFO - PROCESS | 12641 | |8;json-parse-financial;59;58;58;57;57;58;60;69;57;55 14:21:18 INFO - PROCESS | 12641 | |9;json-stringify-tinderbox;60;60;61;63;62;61;60;61;61;61 14:21:18 INFO - PROCESS | 12641 | |10;stanford-crypto-aes;78;93;80;79;78;79;79;80;79;79 14:21:18 INFO - PROCESS | 12641 | |11;stanford-crypto-ccm;123;110;110;108;108;127;109;111;109;116 14:21:18 INFO - PROCESS | 12641 | |12;stanford-crypto-pbkdf2;144;145;141;141;142;142;142;152;140;140 14:21:18 INFO - PROCESS | 12641 | |13;stanford-crypto-sha256-iterative;63;63;63;61;63;64;61;63;60;62 14:21:18 INFO - PROCESS | 12641 | __end_tp_report 14:21:18 INFO - PROCESS | 12641 | __start_cc_report 14:21:18 INFO - PROCESS | 12641 | _x_x_mozilla_cycle_collect,1078 14:21:18 INFO - PROCESS | 12641 | __end_cc_report 14:21:18 INFO - PROCESS | 12641 | __startTimestamp1459286478525__endTimestamp 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | ------- Summary: start ------- 14:21:18 INFO - PROCESS | 12641 | Number of tests: 14 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.00 stddev:4.27 (3.9%) stddev-sans-first:4.43 14:21:18 INFO - PROCESS | 12641 | Values: 110.0 110.0 103.0 110.0 110.0 110.0 97.0 108.0 109.0 107.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:159.00 stddev:19.68 (12.4%) stddev-sans-first:20.33 14:21:18 INFO - PROCESS | 12641 | Values: 161.0 128.0 157.0 167.0 127.0 166.0 152.0 127.0 174.0 124.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 14:21:18 INFO - PROCESS | 12641 | Values: 162.0 161.0 162.0 161.0 161.0 160.0 159.0 163.0 161.0 162.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#3] audio-fft Cycles:10 Average:88.60 Median:74.50 stddev:18.28 (24.5%) stddev-sans-first:18.81 14:21:18 INFO - PROCESS | 12641 | Values: 76.0 77.0 105.0 101.0 75.0 73.0 75.0 121.0 109.0 74.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.21 (25.0%) stddev-sans-first:24.35 14:21:18 INFO - PROCESS | 12641 | Values: 98.0 93.0 141.0 92.0 93.0 93.0 140.0 93.0 92.0 143.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:21:18 INFO - PROCESS | 12641 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:21:18 INFO - PROCESS | 12641 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:21:18 INFO - PROCESS | 12641 | Values: 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:58.00 stddev:3.82 (6.6%) stddev-sans-first:4.06 14:21:18 INFO - PROCESS | 12641 | Values: 59.0 58.0 58.0 57.0 57.0 58.0 60.0 69.0 57.0 55.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 14:21:18 INFO - PROCESS | 12641 | Values: 60.0 60.0 61.0 63.0 62.0 61.0 60.0 61.0 61.0 61.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:4.48 (5.7%) stddev-sans-first:4.66 14:21:18 INFO - PROCESS | 12641 | Values: 78.0 93.0 80.0 79.0 78.0 79.0 79.0 80.0 79.0 79.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#11] stanford-crypto-ccm Cycles:10 Average:113.10 Median:110.50 stddev:6.74 (6.1%) stddev-sans-first:6.12 14:21:18 INFO - PROCESS | 12641 | Values: 123.0 110.0 110.0 108.0 108.0 127.0 109.0 111.0 109.0 116.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:142.00 stddev:3.57 (2.5%) stddev-sans-first:3.77 14:21:18 INFO - PROCESS | 12641 | Values: 144.0 145.0 141.0 141.0 142.0 142.0 142.0 152.0 140.0 140.0 14:21:18 INFO - PROCESS | 12641 | 14:21:18 INFO - PROCESS | 12641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:63.00 stddev:1.25 (2.0%) stddev-sans-first:1.30 14:21:18 INFO - PROCESS | 12641 | Values: 63.0 63.0 63.0 61.0 63.0 64.0 61.0 63.0 60.0 62.0 14:21:18 INFO - PROCESS | 12641 | -------- Summary: end -------- 14:21:18 INFO - PROCESS | 12641 | 14:21:19 INFO - TEST-INFO | 12641: exit 0 14:21:19 INFO - TEST-OK | kraken | took 59612ms 14:21:19 INFO - SUITE-END | took 1170s 14:21:19 INFO - Completed test suite (00:19:30) 14:21:19 INFO - javascript benchmark 14:21:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3040.832754198518, 3071.20148761322, 3072.1398008557603, 3080.0605815226345, 3106.968930310697, 5143.125668636331, 5185.688858668478, 5200.115980283352, 5218.29553010344, 5253.763580638871, 5215.921761173586, 5219.86950326242, 5226.320578324822, 5300.602454815895, 5302.602304827144, 4690.296455531663, 4720.15037293288, 4778.378810754597, 4796.97601511992, 4850.4179498460235, 4660.836870709526, 4757.405324334458, 4795.520447955211, 4801.231802911535, 4817.325574419584, 4683.742394168319, 4739.170645137087, 4742.9525704742855, 4768.070226305872, 4792.664513484057, 4772.379590653228, 4782.784774685148, 4782.976085119587, 4789.521047895182, 4821.349117869077, 4643.489216186217, 4717.103750287469, 4743.95256047442, 4756.661309842645, 4808.63935204861, 5078.64449488536, 5094.923576146323, 5108.055009823158, 5129.717865517395, 5140.3060586820675, 5526.253955716007, 5527.226188333637, 5528.778848846041, 5531.1426728857095, 5569.192467092289, 5409.5672346212605, 5535.474129957647, 5597.356304025048, 5609.915851262234, 5665.0, 5244.160934250502, 5259.579233661298, 5261.605379596507, 5264.341957255343, 5291.708956007418, 5708.257926469615, 5709.885802283931, 5710.486056254957, 5711.514521265656, 5713.371529131792, 5335.359756829205, 5423.511883930465, 5493.121100623881, 5495.065838807413, 5497.890042199214, 5610.831675049755, 5628.971855140698, 5629.802956896489, 5633.746481408347, 5636.85907852307, 5589.636673616202, 5606.60753747242, 5621.747021384048, 5622.6345287557, 5623.550115990711, 5447.972760136174, 5545.417731138173, 5596.244506991586, 5622.746976386073, 5649.774009039675, 4230.767307798039, 4236.724612900213, 4237.216115018731, 4241.363795430649, 4273.658107351404, 3737.1965027518672, 3799.886003419902, 3808.143167787281, 3839.9040023999623, 3855.614438556122, 5260.184671375943, 5298.602604804655, 5339.279197308391, 5347.652402593819, 5350.678959262456, 5492.917606235909, 5542.057850165482, 5544.362398324244, 5547.805826796042, 5549.250851135126, 5200.817971370984, 5211.2443695663915, 5216.634835561475, 5220.791168353299, 5258.92111618326, 4486.775661216926, 4492.326151077365, 4532.297493888453, 4574.725516469022, 4582.633389328846, 5739.081746920473, 5784.479396854304, 5788.7684492620665, 5789.450002249864, 5794.971025144931, 5422.322209723785, 5568.303962004749, 5605.887882242414, 5610.691411972381, 5660.886782264414, 5664.745086471201, 5717.42825717425, 5735.512481439125, 5740.0815869460685, 5759.625624334405, 5535.363433205233, 5571.860703482445, 5572.387037425961, 5577.525910297508, 5579.860503487445, 5520.309961254843, 5615.354234263112, 5647.7176141193595, 5649.519790817662, 5651.15232715096, 5460.699661518495, 5512.39363670004, 5512.834614961557, 5549.112142057252, 5567.832965011056, 5341.412444631165, 5387.138057910715, 5392.946070539401, 5393.757280922289, 5400.567954563704, 5281.762320695655, 5326.2276969838385, 5328.49379308965, 5353.759080841293, 5379.973100134474, 5501.944980550144, 5512.862178445571, 5519.3652729936575, 5524.696141712084, 5572.192032155233, 5378.623496355218, 5382.838514844561, 5384.353877534721, 5390.460953904578, 5436.048691478896], "unit": "score", "name": "dojo.html", "value": 5138.0861059667395}, {"lowerIsBetter": false, "replicates": [564.1776571935101, 574.9453801888819, 577.6274303074517, 595.3391735173956, 657.4575974820774, 30714.38571228574, 39743.80128099359, 39863.60136398635, 39901.60098399015, 40027.399589006185, 41867.58132418675, 42387.788061059655, 42495.15009699812, 42552.78723606385, 42580.36129458061, 7951.483153595027, 8636.13638636136, 8805.69180078694, 8826.205641492264, 10098.141657959046, 10304.330218535808, 10445.58217671296, 10446.791064178711, 10449.477526123701, 10450.738731531697, 10421.583136674524, 10540.262181647287, 10548.841767373495, 10549.314294570866, 10561.260711750181, 10367.118794902442, 10466.633667821628, 10474.42390668513, 10475.528601212925, 10476.947615261952, 10205.132563732092, 10343.224258180666, 10348.741281467948, 10352.223583231287, 10638.946805266001, 42557.0, 42970.78514607407, 42996.57003429957, 43001.1399772006, 43053.354199687026, 3600.891973240807, 3642.1440961374055, 4110.486189226347, 4243.830246790125, 4269.573042695737, 32524.512132318036, 32964.6703532964, 33000.3399932, 33101.834490827634, 33329.6667033329, 4183.226103170923, 4280.5291417944, 4314.223439780838, 4318.719283246579, 4375.8249670013165, 328416.0, 328815.0, 329277.3536132328, 329818.0, 330176.0, 58251.0, 58493.70753146207, 58495.415045849, 58512.0, 58524.707376462844, 68342.65828670825, 68569.65715171491, 68601.31398685949, 68610.65694671495, 68663.31336686669, 15713.450029248921, 17028.233729482203, 17158.914205428893, 17163.0, 17190.828091719173, 12492.81260781089, 12560.81158782619, 12562.05784566143, 12575.0, 12580.81128783069, 20396.0, 20861.58276834455, 20934.162633494794, 20970.685439718418, 21001.89499052495, 7210.134783825974, 7515.248475152551, 7709.884351734729, 7724.227577242231, 7812.882806757903, 1101.0472404069428, 1110.0675432636624, 1121.725177331559, 1191.8450601421932, 1204.175140029083, 32979.0, 33086.66913330836, 33118.50322245168, 33399.4990075149, 33838.83080584581, 1085.2132204151926, 1203.3983008495752, 1263.6145975477384, 1289.1684863263142, 1311.1477539599337, 17074.48776536706, 17085.316587336616, 17090.40183593568, 17113.743293850603, 17116.74324885128, 403415.0, 405890.0, 411783.0, 411837.0, 412176.0, 59794.70102649546, 59983.700081499315, 60115.09827352593, 60122.39877601168, 60236.0, 1296.2157894473896, 1310.33173081729, 1396.4763213794827, 1419.2407062221869, 1435.798988141661, 30930.226744331572, 31753.20616984594, 32855.342893141526, 33024.50463243102, 33042.0, 48607.75696121497, 49246.0, 49724.50275497344, 49806.750966246385, 49829.25256121089, 310954.0, 317531.0, 318155.0, 318610.0, 318933.0, 39398.80300598479, 47322.0, 47414.52585474101, 47461.0, 48490.0, 46051.0, 46286.768566156956, 46760.7661961688, 47840.0, 47875.52124478711, 39176.62220054995, 39740.205195896495, 43386.38598172389, 43721.12557748891, 44203.33694994642, 42211.577884221995, 42425.36361954635, 43034.56965430306, 44063.55936440595, 44118.0, 43181.13637727291, 43609.781951090044, 44027.33958990554, 44235.55764442314, 44270.11459770851, 37557.81221093877, 38564.42153367758, 38812.223755524166, 39152.80423597864, 39233.803830980665, 29399.534430273936, 29924.55113173348, 30102.548461773527, 30178.2455438607, 30197.547036794025], "unit": "score", "name": "ext.html", "value": 20826.081656927043}, {"lowerIsBetter": false, "replicates": [378.07749092214993, 380.35339922132374, 380.57755890961045, 386.8916703323069, 389.41976455081937, 17459.912700436496, 18067.81932180678, 18727.15727792249, 18755.15601797919, 18770.81229187708, 13664.521741739041, 17083.145842707876, 17715.114244287797, 17731.29074837005, 17752.733708994376, 5007.449180590123, 5202.115640341132, 5235.869103272411, 5236.764345604457, 5238.345206849144, 3865.7100717446165, 5410.48600382963, 5623.409541998092, 5639.15412688096, 5642.463965923231, 5626.352969408509, 5627.8593035174035, 5628.0, 5641.717914104299, 5646.520045796112, 5761.395053519383, 6142.600730952474, 6157.2919114301985, 6182.196314479112, 6188.350223226564, 5474.91787623186, 5483.369412517572, 5484.122540393518, 5489.176623506466, 5499.697516636584, 13243.73512529744, 13595.52415665447, 13597.86402135976, 13601.047926645138, 13626.523071692542, 2175.7497887742798, 2684.81206315558, 2849.230707708907, 2983.1498023063323, 3012.171652795477, 5957.553183511254, 10190.643327483576, 10428.113610343129, 10438.947805261001, 11234.269772464846, 1885.4626431467104, 1964.4597735622676, 1983.9702404463944, 2038.908249128778, 2091.895405229732, 65778.0, 66313.3368666312, 69297.65351173263, 69316.30683693099, 70707.0, 10136.847947280796, 10375.0, 10585.465107559361, 10636.149108071335, 10677.78644427107, 14297.571072867831, 14301.28493575338, 14364.856351436352, 14443.927780361031, 14447.133172009713, 7945.642446089824, 8157.592120393957, 8199.631016604268, 8241.79395515105, 8262.586870656443, 7900.525968441912, 7992.5204487730925, 8035.437519373588, 8060.395470339748, 8130.634121464548, 4433.756143412079, 4559.224931761609, 4562.270036794097, 4571.839985600554, 4613.469451013109, 1756.2360373237682, 1765.1819535765903, 1826.6620675175136, 1839.9908000459911, 1895.4976931113265, 957.8084383123403, 1038.924712922122, 1063.4948399510172, 1096.0760477490564, 1116.7152376144193, 17599.20803563843, 17676.11619419024, 17944.19251133702, 18011.72982405265, 18291.81708182928, 1006.4313662780505, 1009.1623952119724, 1035.140833108518, 1035.6530562261726, 1084.8481212630238, 10105.848412273821, 10250.436226007641, 10480.895191048145, 10544.0, 10746.462676866126, 376891.0, 382106.0, 384009.0, 386309.0, 502125.0, 82725.0, 86507.56746216229, 88187.55906220428, 88302.0, 88748.0, 1044.8171569975225, 1074.4681382715605, 1090.738222826516, 1096.8848270931596, 1116.8268918317674, 16457.341706331612, 16551.66896662084, 16583.419580315112, 16726.247318870923, 17017.06406147624, 36510.8174459126, 36692.266154677294, 37165.81417092897, 37663.81168094142, 38260.23479530338, 50499.0, 53949.46050539445, 54542.18186727282, 55618.44381556295, 56144.157837631654, 8271.751847444586, 8367.246947774729, 8388.370872184489, 8570.48577085377, 8701.8694719578, 9579.473128977974, 12312.753744924872, 12652.620421387373, 12695.238285702888, 13188.0, 5777.133429985536, 7392.96303518479, 10197.9490102549, 11466.82799758021, 11865.347405892759, 11394.37330946806, 11501.827472588086, 11554.537818487503, 11829.408529573315, 11847.822282665595, 6099.054646529795, 8228.724547695118, 9636.46999415011, 10306.381617102998, 11618.244814087057, 8337.583120844054, 8436.789080273042, 8450.957745211235, 8613.784655383415, 8733.08302628215, 10720.946395267974, 11549.711257218301, 11713.355765432983, 11879.287242765462, 12118.394080296126], "unit": "score", "name": "jquery.html", "value": 8688.894455117135}, {"lowerIsBetter": false, "replicates": [1349.7165595225001, 1458.9051711638742, 1461.7588097963837, 1651.7439796831488, 1837.0171958002463, 7785.338246249068, 7968.402369822257, 7992.640331185096, 7999.600019998991, 8033.397495187855, 7879.4484386093, 8081.797955051126, 8093.109757926623, 8125.715599954003, 8129.5528745918955, 2104.8737075775425, 2298.712660917385, 2399.448126930807, 2430.513897220554, 2467.592847180213, 2429.8056155507516, 2443.841150325232, 2444.1079006162713, 2445.1686426614947, 2445.9388515287083, 2346.1905642553293, 2432.781049705526, 2434.793042591373, 2437.366284765965, 2437.8415402998835, 2377.0, 2396.892139853711, 2416.8791560421996, 2419.5040016796515, 2424.5635785558593, 2385.85684858909, 2394.2697477269426, 2411.2525117213545, 2447.645091461728, 2464.913728019511, 8064.758057258292, 8149.633266503021, 8154.776783482465, 8164.306033987118, 8173.182681731839, 5115.897682046376, 5248.21276808478, 5266.078436273637, 5284.682919024871, 5286.867828304285, 3343.9498407523906, 3420.110771199481, 3572.8749493767596, 3580.1765593913547, 3581.767185132958, 1132.1904838040841, 1138.681169272605, 1139.3164101539094, 1160.5705888821105, 1175.864775550814, 11616.59341923037, 11642.76714465706, 11647.534098636044, 11655.59205427806, 11657.009154221902, 4585.70192937458, 4625.4911959684405, 4692.788824502905, 4727.7163370197895, 4728.1252968201, 9782.364146330467, 9782.853257201148, 9784.706458806248, 9795.755106122404, 9826.508674566243, 4647.0, 5144.176931690987, 5144.871378215575, 5156.871078223075, 5160.045391602491, 4502.549745025472, 4574.130915126116, 4626.028534007896, 4627.722336659811, 4636.304554316812, 3873.6901047916663, 3960.5841386653988, 3977.4033894915992, 3996.3805610130476, 4034.9798251008556, 1267.2649863079391, 1292.2956988441322, 1292.6315999939973, 1293.3985696651102, 1308.784050631654, 1392.5335012770634, 1397.5667543061684, 1407.507372419645, 1438.2305466575333, 1441.5963530211557, 7995.440319177718, 8005.199480051948, 8052.677892884336, 8059.395545334123, 8059.476134051268, 502.2817371159204, 504.5383474121138, 509.93370861788475, 510.1684254664947, 518.4271380124983, 6202.596831205957, 6240.344763799736, 6258.624482531062, 6320.589161704566, 6328.6202827830475, 9991.300608957448, 10279.794404111875, 10293.948530257301, 10300.433476158883, 10310.278280520291, 9485.573149208301, 9935.503224838729, 10001.299909006446, 10036.64871729486, 10069.69790906274, 7620.1998790127345, 7687.461877668621, 7695.730649427243, 7718.845623087507, 7723.884141737878, 7674.117476490275, 7694.653740581575, 7748.186440423674, 7765.844683106419, 7781.688732450639, 8607.311415086904, 8876.556172191236, 8951.239144672776, 8974.102589740975, 8976.461412315282, 8940.955295223483, 9030.729078127666, 9183.357164998653, 9238.445693258425, 9290.303227257848, 6366.522510811615, 6566.737330506918, 7034.366906978396, 7046.612436315847, 7182.174049984319, 7833.686652533835, 7850.921490785019, 7927.16764739694, 7937.166597507178, 7942.920570794218, 6948.374646281859, 7144.464165187528, 7173.641317934187, 7191.460640451883, 7305.671244794104, 7039.331263529956, 7057.752978645723, 7091.60996145217, 7105.46708996817, 7149.428045756431, 7238.312360325761, 7377.114746230487, 7382.483226174117, 7391.926080739124, 7406.962965185139, 6850.143732033496, 6863.794086177422, 6882.070920425678, 6885.621290828852, 6906.171259448898, 6952.130983627047, 6969.58182509051, 7041.5422997505, 7054.08296921397, 7060.188078371053], "unit": "score", "name": "mootools.html", "value": 4694.8557290797535}, {"lowerIsBetter": false, "replicates": [350.3308680420396, 350.5679300059258, 354.2136457065315, 356.1559104921336, 359.62419271860887, 6032.366601506845, 6033.487153591945, 6041.939580604193, 6051.878962420749, 6059.333473317932, 5995.520358371331, 5997.850053748648, 5998.010328295826, 6009.308929473112, 6014.097885317205, 4454.57681520255, 4508.174189453261, 4604.700694454867, 4636.5595268449615, 4664.043871006435, 4607.884802879921, 4613.746243956581, 4623.075384923012, 4631.814727410916, 4635.8841028974375, 4588.24293991491, 4594.035252596958, 4597.632189424855, 4603.585677289043, 4609.492955774879, 4401.031773009932, 4512.007358381151, 4616.146012987608, 4623.768811559442, 4636.536346365337, 4081.734687245349, 4098.877033688994, 4108.281050816096, 4108.712390132692, 4113.341865301538, 5790.7973220937065, 5791.247137872092, 5791.942080579224, 5793.65238085712, 5794.246747922785, 5372.328458942632, 5390.0836857734275, 5390.1914712793005, 5392.056390131711, 5393.19102134679, 6300.842478938063, 6323.146375239376, 6325.588836725644, 6329.873402531924, 6330.620162790201, 4307.8492252771, 4388.0, 4390.692651514395, 4422.911541769179, 4542.863714088583, 6566.376194261537, 6580.045893345438, 6626.072349871022, 6627.271000189975, 6637.93362066378, 4529.071540334224, 4534.501204867462, 4542.227821270392, 4543.091381723602, 4543.977280113579, 4592.15045216636, 4596.402467679247, 4599.218132917412, 4601.976990115028, 4605.286180642006, 5285.762140703678, 5292.497212764782, 5293.973530132324, 5297.973510132425, 5309.973450132725, 6212.0, 6398.9040164397575, 6405.29541750407, 6408.295087540367, 6436.967815160894, 1596.9441069562743, 1602.7675986982056, 1614.3946020242408, 1617.3126421270913, 1624.6750649870073, 1012.422918936214, 1035.1873779083535, 1039.8440233964966, 1081.1296905990596, 1090.3022065877844, 6028.276606807123, 6038.426349496791, 6053.243344581927, 6092.573519853657, 6104.755809767648, 6502.804915852532, 6504.609723416515, 6506.674666266667, 6514.120593719882, 6521.184851893513, 6062.787802426894, 6089.2997305310455, 6094.542909281821, 6099.359567245464, 6099.542534309856, 3484.738644601665, 3514.5431093957623, 3518.2787528556582, 3522.9823850881094, 3523.207278362348, 6641.402273795382, 6691.698873550702, 6850.691718872663, 6851.2806155353965, 6872.41584465316, 6725.529212955144, 6753.12209412783, 6819.659017049128, 6826.829329266709, 6834.1457317835275, 6836.282190370039, 6852.109225800714, 6853.451723862079, 6855.143107111611, 6857.691403886937, 6662.200535935719, 6720.092787473628, 6726.764563240263, 6737.494687898526, 6739.359760822714, 6443.677816109082, 6485.383888530582, 6572.967135164294, 6575.342465753386, 6579.6313327203125, 6786.778379891667, 6833.453323734188, 6833.89749153773, 6834.179898412222, 6836.726530938906, 4521.2087884619405, 4522.773861306987, 4533.387992620954, 4537.0, 4543.7955292011275, 6611.801645950629, 6621.735130594722, 6625.734970601315, 6631.336866313523, 6640.07039014548, 6343.061199359685, 6402.487800975818, 6446.387593178828, 6456.903146452713, 6480.027995800668, 6398.872022559616, 6426.325235850169, 6428.228612566522, 6435.388638079375, 6441.066045423481, 6288.0882272069375, 6298.244210694746, 6308.52686048539, 6325.96837015812, 6327.936720632919, 6484.448821850196, 6517.4460170886005, 6541.967290163519, 6545.14913061299, 6545.37818907203, 6017.699115044318, 6107.480864126599, 6210.937890621036, 6240.564670125806, 6303.0], "unit": "score", "name": "prototype.html", "value": 4825.300137115502}, {"lowerIsBetter": false, "replicates": [752.6575408189275, 758.2455456820464, 858.3390789092399, 859.9269062129719, 870.6299822575404, 13981.231032293219, 14073.507427240049, 14113.929430352846, 14116.788248176286, 14119.223442710647, 14178.645533861658, 14252.572422827332, 14255.71488570228, 14276.214808185545, 14282.4287028519, 669.1267895396505, 817.284875733733, 836.1847198981005, 839.5676226743202, 839.911809260028, 816.3713940265992, 826.9669213231464, 828.1635548096406, 829.266099501939, 832.8084540555676, 710.4955481608039, 867.7657032601194, 872.0799556467924, 873.6680061576624, 875.995620021899, 707.5188871567332, 713.4185638704439, 861.1775754154799, 873.2402809555728, 875.4528419737663, 613.3529126771255, 616.2143267334185, 619.9938000619982, 620.1287191495956, 621.5369549685513, 14156.504522341771, 14181.0, 14217.146971181763, 14241.287935603283, 14267.357968891321, 13634.386452609657, 13793.655158621015, 13815.240161791098, 13822.101563398448, 13939.581812545639, 11062.336259824437, 11277.0, 11762.411879406081, 12101.455434505468, 12342.0, 3855.8843234703004, 3859.8842034738723, 3919.3533067043904, 3931.4495970564144, 3966.7421617594764, 54308.18537721937, 54805.45194548043, 54822.451775482135, 54848.725756370965, 54871.72564137154, 10929.945350273198, 11280.379579123228, 11449.370284634426, 11545.942270288595, 11866.88133118675, 20401.89799050995, 20719.896400518202, 20738.896305518676, 20743.170273189204, 20743.58512829765, 8525.829483410296, 8541.103184165697, 8618.138186181332, 8741.781455463537, 9020.413673111227, 4776.0, 4917.680350777188, 4953.72754498506, 4965.131102057126, 5059.418166910778, 3364.6467120951947, 3384.0, 3404.9489257661153, 3413.992872102736, 3414.0270023043313, 588.5232961301359, 628.8335138318354, 632.2413104274889, 648.4293821437105, 654.4633400611453, 693.9444844412435, 760.3347071312602, 767.8963339949147, 776.8601651702635, 796.80079980005, 9016.63933442668, 9143.954280228556, 9654.903450965541, 9735.069600359284, 9829.223331362353, 722.9493935424575, 728.1989811207735, 743.4461326311824, 756.4666909828558, 759.0, 4442.244818380883, 4475.48531918827, 4479.910401792011, 4652.744099074515, 4750.334953106568, 52831.471685283424, 53474.7326263374, 64782.0, 65348.67325663436, 65370.0, 54739.17891231635, 55578.72210638921, 56148.0, 56354.0, 56437.0, 49642.0, 49730.0, 49945.50054499409, 50438.74780626073, 50516.49483505191, 9527.76180595463, 9623.374480658735, 9648.807023859343, 9714.0, 9850.374688176371, 37876.0, 37957.810210948766, 38841.6115838838, 38959.6104038956, 39423.40864887086, 44743.77628111969, 49648.751756240985, 49906.0, 50350.496495036045, 50915.2362714567, 11651.184417090722, 12086.576969806014, 12208.023358131506, 12298.385080746106, 12337.568185113478, 12086.335251560897, 12357.75284494287, 12435.156145488072, 12518.749625007267, 12775.488980440678, 9992.300538962203, 12500.310891138142, 12772.233665980071, 12914.418851151908, 13896.86103138996, 12060.757423941352, 12861.807072893727, 13320.800187997382, 13351.933240334125, 13504.122232055279, 12248.0, 12343.950764184785, 12618.495260189857, 13016.544420945222, 13866.445342186604, 11086.0, 11102.2783519071, 11245.943770281096, 11325.603603873826, 11554.480048397674, 10480.475976201007, 11127.72180695489, 11588.536458541565, 11629.302241865515, 11927.880721193023], "unit": "score", "name": "yui.html", "value": 6886.415115108282}], "name": "dromaeo_css", "value": 7248.683125293469}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 103.0, 110.0, 110.0, 110.0, 97.0, 108.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [161.0, 128.0, 157.0, 167.0, 127.0, 166.0, 152.0, 127.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 159.0, 163.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 105.0, 101.0, 75.0, 73.0, 75.0, 121.0, 109.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [98.0, 93.0, 141.0, 92.0, 93.0, 93.0, 140.0, 93.0, 92.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 57.0, 57.0, 58.0, 60.0, 69.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 63.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.0}, {"lowerIsBetter": true, "replicates": [78.0, 93.0, 80.0, 79.0, 78.0, 79.0, 79.0, 80.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [123.0, 110.0, 110.0, 108.0, 108.0, 127.0, 109.0, 111.0, 109.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.1}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 141.0, 141.0, 142.0, 142.0, 142.0, 152.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 61.0, 63.0, 64.0, 61.0, 63.0, 60.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.3}], "name": "kraken", "value": 1490.7}]} 14:21:19 INFO - Return code: 0 14:21:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:21:19 ERROR - # TBPL SUCCESS # 14:21:19 INFO - Running post-action listener: _resource_record_post_action 14:21:19 INFO - Running post-run listener: _resource_record_post_run 14:21:20 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 32768; Write bytes: 543326208; Read time: 68; Write time: 510496 14:21:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 217157632; Read time: 0; Write time: 239976 14:21:20 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 32768; Write bytes: 290676736; Read time: 68; Write time: 260016 14:21:20 INFO - Running post-run listener: _upload_blobber_files 14:21:20 INFO - Blob upload gear active. 14:21:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:21:20 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 14:21:20 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'] 14:21:20 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 14:21:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:21:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:21:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:22 INFO - (blobuploader) - INFO - Done attempting. 14:21:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:21:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:21:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:21:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:23 INFO - (blobuploader) - INFO - Done attempting. 14:21:23 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:23 INFO - Return code: 0 14:21:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:21:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39fab1c7210312eec36c72368065602d96c3b9feb4153a5bd41858c04515ea5b8ef2c3931ae13f9bc26045f66385ea9aa917daa8942d4194d103e5ec7bdcf10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e551814f67c4c940ab6b45f55ebb5d86d2b45666f6f9773ac26ec6eb578034b455f9cbddf0e34652fe51acce7a15b7c16c680909fc57a0bed989d2dcb34a5392"} 14:21:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:21:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:21:23 INFO - Contents: 14:21:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39fab1c7210312eec36c72368065602d96c3b9feb4153a5bd41858c04515ea5b8ef2c3931ae13f9bc26045f66385ea9aa917daa8942d4194d103e5ec7bdcf10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e551814f67c4c940ab6b45f55ebb5d86d2b45666f6f9773ac26ec6eb578034b455f9cbddf0e34652fe51acce7a15b7c16c680909fc57a0bed989d2dcb34a5392"} 14:21:23 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:23 INFO - Copying logs to upload dir... 14:21:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:21:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.409375 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-29 14:21:23.169477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 14:21:23.172804) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39fab1c7210312eec36c72368065602d96c3b9feb4153a5bd41858c04515ea5b8ef2c3931ae13f9bc26045f66385ea9aa917daa8942d4194d103e5ec7bdcf10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e551814f67c4c940ab6b45f55ebb5d86d2b45666f6f9773ac26ec6eb578034b455f9cbddf0e34652fe51acce7a15b7c16c680909fc57a0bed989d2dcb34a5392"} build_url:https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/HV3b_G43RHKYBzgNpZ3NXQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39fab1c7210312eec36c72368065602d96c3b9feb4153a5bd41858c04515ea5b8ef2c3931ae13f9bc26045f66385ea9aa917daa8942d4194d103e5ec7bdcf10c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e551814f67c4c940ab6b45f55ebb5d86d2b45666f6f9773ac26ec6eb578034b455f9cbddf0e34652fe51acce7a15b7c16c680909fc57a0bed989d2dcb34a5392"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 14:21:23.216902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 14:21:23.217288) ========= 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=20e666a3d4cfbb71505a330e000001b4-1459284807.120274-982832120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 14:21:23.318807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 14:21:23.319173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 14:21:23.322565) ========= ========= Total master_lag: 0.31 =========