builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1457784299.3 results: success (0) buildid: 20160312013032 builduid: db3eadda6abe44c18156da09ca85e2b5 revision: ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.296991) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.297494) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.297785) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006333 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.357747) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.358150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.392887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.393178) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.451407) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.451728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.452097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.452389) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-12 04:04:59-- 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% 39.5M=0s 2016-03-12 04:04:59 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.568185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.568460) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019558 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.619231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:04:59.619553) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 --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/mozilla-inbound --rev ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 --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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-12 04:05:00,114 truncating revision to first 12 chars 2016-03-12 04:05:00,114 Setting DEBUG logging. 2016-03-12 04:05:00,114 attempt 1/10 2016-03-12 04:05:00,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ba5dd6053cc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-12 04:05:00,463 unpacking tar archive at: mozilla-inbound-ba5dd6053cc4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:05:00.278192) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 04:05:00.278686) ========= echo ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4'] 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 program finished with exit code 0 elapsedTime=0.004675 script_repo_revision: 'ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-12 04:05:00.337376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 04:05:00.337662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-12 04:05:00.359850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-12 04:05:00.360192) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:00 INFO - MultiFileLogger online at 20160312 04:05:00 in /builds/slave/test-pgo 04:05:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:05:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:05:00 INFO - {'append_to_log': False, 04:05:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:05:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:05:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:05:00 INFO - 'branch': 'Mozilla-Inbound', 04:05:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:00 INFO - 'config_files': ('talos/linux_config.py',), 04:05:00 INFO - 'default_actions': ('clobber', 04:05:00 INFO - 'read-buildbot-config', 04:05:00 INFO - 'download-and-extract', 04:05:00 INFO - 'populate-webroot', 04:05:00 INFO - 'create-virtualenv', 04:05:00 INFO - 'install', 04:05:00 INFO - 'run-tests'), 04:05:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:00 INFO - 'download_minidump_stackwalk': True, 04:05:00 INFO - 'download_symbols': 'ondemand', 04:05:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:00 INFO - 'installer_path': 'installer.exe', 04:05:00 INFO - 'log_level': 'info', 04:05:00 INFO - 'log_name': 'talos', 04:05:00 INFO - 'log_to_console': True, 04:05:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:00 INFO - 'opt_config_files': (), 04:05:00 INFO - 'pip_index': False, 04:05:00 INFO - 'sps_profile': False, 04:05:00 INFO - 'sps_profile_interval': 0, 04:05:00 INFO - 'suite': 'dromaeojs', 04:05:00 INFO - 'system_bits': '32', 04:05:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:00 INFO - 'title': 'talos-linux64-ix-015', 04:05:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:00 INFO - 'use_talos_json': True, 04:05:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:05:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:00 INFO - 'work_dir': 'build'} 04:05:00 INFO - ##### 04:05:00 INFO - ##### Running clobber step. 04:05:00 INFO - ##### 04:05:00 INFO - Running pre-action listener: _resource_record_pre_action 04:05:00 INFO - Running main action method: clobber 04:05:00 INFO - rmtree: /builds/slave/test-pgo/build 04:05:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:05:01 INFO - Running post-action listener: _resource_record_post_action 04:05:01 INFO - ##### 04:05:01 INFO - ##### Running read-buildbot-config step. 04:05:01 INFO - ##### 04:05:01 INFO - Running pre-action listener: _resource_record_pre_action 04:05:01 INFO - Running main action method: read_buildbot_config 04:05:01 INFO - Using buildbot properties: 04:05:01 INFO - { 04:05:01 INFO - "project": "", 04:05:01 INFO - "product": "firefox", 04:05:01 INFO - "script_repo_revision": "production", 04:05:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:05:01 INFO - "repository": "", 04:05:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:05:01 INFO - "buildid": "20160312013032", 04:05:01 INFO - "pgo_build": "True", 04:05:01 INFO - "basedir": "/builds/slave/test-pgo", 04:05:01 INFO - "buildnumber": 792, 04:05:01 INFO - "slavename": "talos-linux64-ix-015", 04:05:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:01 INFO - "platform": "ubuntu64_hw", 04:05:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:05:01 INFO - "branch": "mozilla-inbound", 04:05:01 INFO - "repo_path": "integration/mozilla-inbound", 04:05:01 INFO - "revision": "ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4", 04:05:01 INFO - "stage_platform": "linux64-pgo", 04:05:01 INFO - "builduid": "db3eadda6abe44c18156da09ca85e2b5", 04:05:01 INFO - "slavebuilddir": "test" 04:05:01 INFO - } 04:05:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:05:01 INFO - Running post-action listener: _resource_record_post_action 04:05:01 INFO - ##### 04:05:01 INFO - ##### Running download-and-extract step. 04:05:01 INFO - ##### 04:05:01 INFO - Running pre-action listener: _resource_record_pre_action 04:05:01 INFO - Running main action method: download_and_extract 04:05:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:01 INFO - https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:05:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:05:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:04 INFO - Downloaded 1361 bytes. 04:05:04 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:05:04 INFO - Using the following test package requirements: 04:05:04 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:04 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:05:04 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:05:04 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'jsshell-linux-x86_64.zip'], 04:05:04 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:05:04 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:05:04 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:05:04 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:05:04 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:05:04 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:05:04 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:05:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:04 INFO - https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:05:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:05:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:06 INFO - Downloaded 23550718 bytes. 04:05:06 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'] 04:05:06 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 04:05:07 INFO - Return code: 0 04:05:07 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 04:05:07 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')]} 04:05:07 INFO - https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:13 INFO - Downloaded 23550718 bytes. 04:05:13 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'] 04:05:13 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 04:05:14 INFO - Return code: 0 04:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:14 INFO - https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:05:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:05:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:15 INFO - Downloaded 10845263 bytes. 04:05:15 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'] 04:05:15 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 04:05:15 INFO - Return code: 0 04:05: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')]} 04:05:15 INFO - https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:17 INFO - Downloaded 57642149 bytes. 04:05:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:05:17 INFO - mkdir: /builds/slave/test-pgo/properties 04:05:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:05:17 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:05:17 INFO - Contents: 04:05:17 INFO - build_url:https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:05:17 INFO - Running post-action listener: _resource_record_post_action 04:05:17 INFO - Running post-action listener: set_extra_try_arguments 04:05:17 INFO - ##### 04:05:17 INFO - ##### Running populate-webroot step. 04:05:17 INFO - ##### 04:05:17 INFO - Running pre-action listener: _resource_record_pre_action 04:05:17 INFO - Running main action method: populate_webroot 04:05:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:17 INFO - '--tppagecycles', 04:05:17 INFO - '7'], 04:05:17 INFO - 'tests': ['tsvgm']}}, 04:05:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:05:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'tests': ['damp', 'tps']}, 04:05:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['damp', 'tps']}, 04:05:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:17 INFO - 'other': {'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'other_l64': {'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:17 INFO - 'ts_paint', 04:05:17 INFO - 'tpaint', 04:05:17 INFO - 'sessionrestore', 04:05:17 INFO - 'sessionrestore_no_auto_restore', 04:05:17 INFO - 'tabpaint']}, 04:05:17 INFO - 'svgr': {'tests': ['tsvgx', 04:05:17 INFO - 'tsvgr_opacity', 04:05:17 INFO - 'tart', 04:05:17 INFO - 'tscrollx', 04:05:17 INFO - 'cart']}, 04:05:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['tsvgx', 04:05:17 INFO - 'tsvgr_opacity', 04:05:17 INFO - 'tart', 04:05:17 INFO - 'tscrollx', 04:05:17 INFO - 'cart']}, 04:05:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'tests': ['tp5o']}, 04:05:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'talos_options': ['--e10s'], 04:05:17 INFO - 'tests': ['tp5o']}, 04:05:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'talos_options': ['--xperf_path', 04:05:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:17 INFO - 'tests': ['tp5n']}, 04:05:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:17 INFO - 'talos_options': ['--e10s', 04:05:17 INFO - '--xperf_path', 04:05:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:17 INFO - 'tests': ['tp5n']}}, 04:05:17 INFO - 'talos.zip': {'path': '', 04:05:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:17 INFO - Running post-action listener: _resource_record_post_action 04:05:17 INFO - ##### 04:05:17 INFO - ##### Running create-virtualenv step. 04:05:17 INFO - ##### 04:05:17 INFO - Running pre-action listener: _resource_record_pre_action 04:05:17 INFO - Running main action method: create_virtualenv 04:05:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:05:17 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 04:05:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:05:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:17 INFO - Using real prefix '/usr' 04:05:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:05:18 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:20 INFO - Installing pip.................done. 04:05:20 INFO - Return code: 0 04:05:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:05:20 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')]} 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 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')]} 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:20 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 04:05:20 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 04:05:20 INFO - Using env: {'DISPLAY': ':0', 04:05:20 INFO - 'HOME': '/home/cltbld', 04:05:20 INFO - 'LANG': 'en_US.UTF-8', 04:05:20 INFO - 'LANGUAGE': 'en_US:en', 04:05:20 INFO - 'LOGNAME': 'cltbld', 04:05:20 INFO - 'MAIL': '/var/mail/cltbld', 04:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:20 INFO - 'MOZ_NO_REMOTE': '1', 04:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:20 INFO - 'NO_EM_RESTART': '1', 04:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:20 INFO - 'SHELL': '/bin/bash', 04:05:20 INFO - 'SHLVL': '1', 04:05:20 INFO - 'TERM': 'linux', 04:05:20 INFO - 'TMOUT': '86400', 04:05:20 INFO - 'USER': 'cltbld', 04:05:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:20 INFO - '_': '/tools/buildbot/bin/python'} 04:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:20 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 04:05:20 INFO - Cleaning up... 04:05:20 INFO - Return code: 0 04:05:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:05:20 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')]} 04:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 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')]} 04:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:20 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:20 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 04:05:20 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 04:05:20 INFO - Using env: {'DISPLAY': ':0', 04:05:20 INFO - 'HOME': '/home/cltbld', 04:05:20 INFO - 'LANG': 'en_US.UTF-8', 04:05:20 INFO - 'LANGUAGE': 'en_US:en', 04:05:20 INFO - 'LOGNAME': 'cltbld', 04:05:20 INFO - 'MAIL': '/var/mail/cltbld', 04:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:20 INFO - 'MOZ_NO_REMOTE': '1', 04:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:20 INFO - 'NO_EM_RESTART': '1', 04:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:20 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:20 INFO - 'SHELL': '/bin/bash', 04:05:20 INFO - 'SHLVL': '1', 04:05:20 INFO - 'TERM': 'linux', 04:05:20 INFO - 'TMOUT': '86400', 04:05:20 INFO - 'USER': 'cltbld', 04:05:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:20 INFO - '_': '/tools/buildbot/bin/python'} 04:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:20 INFO - Downloading/unpacking psutil>=0.7.1 04:05:20 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 04:05:20 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 04:05:20 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 04:05:20 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 04:05:20 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 04:05:20 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 04:05:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:22 INFO - Installing collected packages: psutil 04:05:22 INFO - Running setup.py install for psutil 04:05:22 INFO - building 'psutil._psutil_linux' extension 04:05:22 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 04:05:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:05:23 INFO - building 'psutil._psutil_posix' extension 04:05:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:05:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:23 INFO - Successfully installed psutil 04:05:23 INFO - Cleaning up... 04:05:23 INFO - Return code: 0 04:05:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:05:23 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')]} 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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')]} 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:23 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 04:05:23 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 04:05:23 INFO - Using env: {'DISPLAY': ':0', 04:05:23 INFO - 'HOME': '/home/cltbld', 04:05:23 INFO - 'LANG': 'en_US.UTF-8', 04:05:23 INFO - 'LANGUAGE': 'en_US:en', 04:05:23 INFO - 'LOGNAME': 'cltbld', 04:05:23 INFO - 'MAIL': '/var/mail/cltbld', 04:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:23 INFO - 'MOZ_NO_REMOTE': '1', 04:05:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:23 INFO - 'NO_EM_RESTART': '1', 04:05:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:23 INFO - 'SHELL': '/bin/bash', 04:05:23 INFO - 'SHLVL': '1', 04:05:23 INFO - 'TERM': 'linux', 04:05:23 INFO - 'TMOUT': '86400', 04:05:23 INFO - 'USER': 'cltbld', 04:05:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:23 INFO - '_': '/tools/buildbot/bin/python'} 04:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:05:25 INFO - Installing collected packages: mozsystemmonitor 04:05:25 INFO - Running setup.py install for mozsystemmonitor 04:05:25 INFO - Successfully installed mozsystemmonitor 04:05:25 INFO - Cleaning up... 04:05:25 INFO - Return code: 0 04:05:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:05: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')]} 04:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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', '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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:05: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 blobuploader==1.2.4 04:05:25 INFO - Using env: {'DISPLAY': ':0', 04:05:25 INFO - 'HOME': '/home/cltbld', 04:05:25 INFO - 'LANG': 'en_US.UTF-8', 04:05:25 INFO - 'LANGUAGE': 'en_US:en', 04:05:25 INFO - 'LOGNAME': 'cltbld', 04:05:25 INFO - 'MAIL': '/var/mail/cltbld', 04:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:25 INFO - 'MOZ_NO_REMOTE': '1', 04:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:25 INFO - 'NO_EM_RESTART': '1', 04:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:25 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:25 INFO - 'SHELL': '/bin/bash', 04:05:25 INFO - 'SHLVL': '1', 04:05:25 INFO - 'TERM': 'linux', 04:05:25 INFO - 'TMOUT': '86400', 04:05:25 INFO - 'USER': 'cltbld', 04:05:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:25 INFO - '_': '/tools/buildbot/bin/python'} 04:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:27 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:05:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05:28 INFO - Downloading docopt-0.6.1.tar.gz 04:05:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:28 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:28 INFO - Running setup.py install for blobuploader 04:05:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:05:28 INFO - Running setup.py install for requests 04:05:28 INFO - Running setup.py install for docopt 04:05:28 INFO - Successfully installed blobuploader requests docopt 04:05:28 INFO - Cleaning up... 04:05:28 INFO - Return code: 0 04:05:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05: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')]} 04:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:28 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:28 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 04:05:28 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 04:05:28 INFO - Using env: {'DISPLAY': ':0', 04:05:28 INFO - 'HOME': '/home/cltbld', 04:05:28 INFO - 'LANG': 'en_US.UTF-8', 04:05:28 INFO - 'LANGUAGE': 'en_US:en', 04:05:28 INFO - 'LOGNAME': 'cltbld', 04:05:28 INFO - 'MAIL': '/var/mail/cltbld', 04:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:28 INFO - 'MOZ_NO_REMOTE': '1', 04:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:28 INFO - 'NO_EM_RESTART': '1', 04:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:28 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:28 INFO - 'SHELL': '/bin/bash', 04:05:28 INFO - 'SHLVL': '1', 04:05:28 INFO - 'TERM': 'linux', 04:05:28 INFO - 'TMOUT': '86400', 04:05:28 INFO - 'USER': 'cltbld', 04:05:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:28 INFO - '_': '/tools/buildbot/bin/python'} 04:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:29 INFO - Running setup.py (path:/tmp/pip-YvoHvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:29 INFO - Running setup.py (path:/tmp/pip-h9FZNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:29 INFO - Running setup.py (path:/tmp/pip-7uzEg_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:29 INFO - Running setup.py (path:/tmp/pip-Atj4K4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:29 INFO - Running setup.py (path:/tmp/pip-qTG1tr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:29 INFO - Running setup.py (path:/tmp/pip-zHe5p7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:29 INFO - Running setup.py (path:/tmp/pip-paGeEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:29 INFO - Running setup.py (path:/tmp/pip-slbtsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:29 INFO - Running setup.py (path:/tmp/pip-xjiiHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:29 INFO - Running setup.py (path:/tmp/pip-SRY4bd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:29 INFO - Running setup.py (path:/tmp/pip-ZDFU5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:29 INFO - Running setup.py (path:/tmp/pip-vXjroT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:30 INFO - Running setup.py (path:/tmp/pip-1ftDz2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:30 INFO - Running setup.py (path:/tmp/pip-ZnJuk4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:30 INFO - Running setup.py (path:/tmp/pip-qxH9eV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:30 INFO - Running setup.py (path:/tmp/pip-MY62uR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:30 INFO - Running setup.py (path:/tmp/pip-ze43qO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:30 INFO - Running setup.py install for manifestparser 04:05:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Running setup.py install for mozcrash 04:05:30 INFO - Running setup.py install for mozdebug 04:05:30 INFO - Running setup.py install for mozdevice 04:05:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Running setup.py install for mozfile 04:05:30 INFO - Running setup.py install for mozhttpd 04:05:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:05:30 INFO - Running setup.py install for mozinfo 04:05:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozInstall 04:05:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozleak 04:05:31 INFO - Running setup.py install for mozlog 04:05:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for moznetwork 04:05:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozprocess 04:05:31 INFO - Running setup.py install for mozprofile 04:05:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozrunner 04:05:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:05:31 INFO - Running setup.py install for mozscreenshot 04:05:31 INFO - Running setup.py install for moztest 04:05:32 INFO - Running setup.py install for mozversion 04:05:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:05:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:32 INFO - Cleaning up... 04:05:32 INFO - Return code: 0 04:05:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:32 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')]} 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 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')]} 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:32 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 04:05:32 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 04:05:32 INFO - Using env: {'DISPLAY': ':0', 04:05:32 INFO - 'HOME': '/home/cltbld', 04:05:32 INFO - 'LANG': 'en_US.UTF-8', 04:05:32 INFO - 'LANGUAGE': 'en_US:en', 04:05:32 INFO - 'LOGNAME': 'cltbld', 04:05:32 INFO - 'MAIL': '/var/mail/cltbld', 04:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:32 INFO - 'MOZ_NO_REMOTE': '1', 04:05:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:32 INFO - 'NO_EM_RESTART': '1', 04:05:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:32 INFO - 'SHELL': '/bin/bash', 04:05:32 INFO - 'SHLVL': '1', 04:05:32 INFO - 'TERM': 'linux', 04:05:32 INFO - 'TMOUT': '86400', 04:05:32 INFO - 'USER': 'cltbld', 04:05:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:32 INFO - '_': '/tools/buildbot/bin/python'} 04:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:32 INFO - Running setup.py (path:/tmp/pip-HnkIiY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:32 INFO - Running setup.py (path:/tmp/pip-pM6WPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:32 INFO - Running setup.py (path:/tmp/pip-1c1523-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:32 INFO - Running setup.py (path:/tmp/pip-2tWd7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:32 INFO - Running setup.py (path:/tmp/pip-c0IEiu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:32 INFO - Running setup.py (path:/tmp/pip-mjpOqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:32 INFO - Running setup.py (path:/tmp/pip-EEkW3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:32 INFO - Running setup.py (path:/tmp/pip-Ccz8j8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:05:32 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)) 04:05:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:32 INFO - Running setup.py (path:/tmp/pip-D_McTf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:33 INFO - Running setup.py (path:/tmp/pip-q97qwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:33 INFO - Running setup.py (path:/tmp/pip-mGAt1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:33 INFO - Running setup.py (path:/tmp/pip-IckdRp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:33 INFO - Running setup.py (path:/tmp/pip-c1UCbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:33 INFO - Running setup.py (path:/tmp/pip-SpDXD7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:33 INFO - Running setup.py (path:/tmp/pip-qNoHUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:33 INFO - Running setup.py (path:/tmp/pip-oK7WWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:05:33 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)) 04:05:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:33 INFO - Running setup.py (path:/tmp/pip-4GDFOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:33 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 04:05:33 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 04:05:33 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 04:05:33 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 04:05:33 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 04:05:33 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 04:05:35 INFO - Downloading blessings-1.6.tar.gz 04:05:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:35 INFO - Installing collected packages: blessings 04:05:35 INFO - Running setup.py install for blessings 04:05:35 INFO - Successfully installed blessings 04:05:35 INFO - Cleaning up... 04:05:35 INFO - Return code: 0 04:05:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:05:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:35 INFO - Reading from file tmpfile_stdout 04:05:35 INFO - Current package versions: 04:05:35 INFO - argparse == 1.2.1 04:05:35 INFO - blessings == 1.6 04:05:35 INFO - blobuploader == 1.2.4 04:05:35 INFO - docopt == 0.6.1 04:05:35 INFO - manifestparser == 1.1 04:05:35 INFO - mozInstall == 1.12 04:05:35 INFO - mozcrash == 0.17 04:05:35 INFO - mozdebug == 0.1 04:05:35 INFO - mozdevice == 0.48 04:05:35 INFO - mozfile == 1.2 04:05:35 INFO - mozhttpd == 0.7 04:05:35 INFO - mozinfo == 0.9 04:05:35 INFO - mozleak == 0.1 04:05:35 INFO - mozlog == 3.1 04:05:35 INFO - moznetwork == 0.27 04:05:35 INFO - mozprocess == 0.22 04:05:35 INFO - mozprofile == 0.28 04:05:35 INFO - mozrunner == 6.11 04:05:35 INFO - mozscreenshot == 0.1 04:05:35 INFO - mozsystemmonitor == 0.0 04:05:35 INFO - moztest == 0.7 04:05:35 INFO - mozversion == 1.4 04:05:35 INFO - psutil == 3.1.1 04:05:35 INFO - requests == 1.2.3 04:05:35 INFO - wsgiref == 0.1.2 04:05:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:35 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:35 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 04:05:35 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 04:05:35 INFO - Using env: {'DISPLAY': ':0', 04:05:35 INFO - 'HOME': '/home/cltbld', 04:05:35 INFO - 'LANG': 'en_US.UTF-8', 04:05:35 INFO - 'LANGUAGE': 'en_US:en', 04:05:35 INFO - 'LOGNAME': 'cltbld', 04:05:35 INFO - 'MAIL': '/var/mail/cltbld', 04:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:35 INFO - 'MOZ_NO_REMOTE': '1', 04:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:35 INFO - 'NO_EM_RESTART': '1', 04:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:35 INFO - 'SHELL': '/bin/bash', 04:05:35 INFO - 'SHLVL': '1', 04:05:35 INFO - 'TERM': 'linux', 04:05:35 INFO - 'TMOUT': '86400', 04:05:35 INFO - 'USER': 'cltbld', 04:05:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:35 INFO - '_': '/tools/buildbot/bin/python'} 04:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 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)) 04:05:36 INFO - Cleaning up... 04:05:36 INFO - Return code: 0 04:05:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:05:36 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')]} 04:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 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')]} 04:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:36 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 04:05:36 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 04:05:36 INFO - Using env: {'DISPLAY': ':0', 04:05:36 INFO - 'HOME': '/home/cltbld', 04:05:36 INFO - 'LANG': 'en_US.UTF-8', 04:05:36 INFO - 'LANGUAGE': 'en_US:en', 04:05:36 INFO - 'LOGNAME': 'cltbld', 04:05:36 INFO - 'MAIL': '/var/mail/cltbld', 04:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:36 INFO - 'MOZ_NO_REMOTE': '1', 04:05:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:36 INFO - 'NO_EM_RESTART': '1', 04:05:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:36 INFO - 'SHELL': '/bin/bash', 04:05:36 INFO - 'SHLVL': '1', 04:05:36 INFO - 'TERM': 'linux', 04:05:36 INFO - 'TMOUT': '86400', 04:05:36 INFO - 'USER': 'cltbld', 04:05:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:36 INFO - '_': '/tools/buildbot/bin/python'} 04:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:36 INFO - Downloading/unpacking jsonschema 04:05:36 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 04:05:36 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 04:05:36 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 04:05:36 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 04:05:36 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 04:05:36 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 04:05:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:38 INFO - Downloading/unpacking functools32 (from jsonschema) 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:38 INFO - warning: no files found matching '*.txt' 04:05:38 INFO - no previously-included directories found matching 'build' 04:05:38 INFO - no previously-included directories found matching 'dist' 04:05:38 INFO - no previously-included directories found matching '.git*' 04:05:38 INFO - Installing collected packages: jsonschema, functools32 04:05:38 INFO - Running setup.py install for functools32 04:05:38 INFO - warning: no files found matching '*.txt' 04:05:38 INFO - no previously-included directories found matching 'build' 04:05:38 INFO - no previously-included directories found matching 'dist' 04:05:38 INFO - no previously-included directories found matching '.git*' 04:05:38 INFO - Successfully installed jsonschema functools32 04:05:38 INFO - Cleaning up... 04:05:38 INFO - Return code: 0 04:05:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:05:38 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')]} 04:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:38 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')]} 04:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:38 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 0x7ff2aa155f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, '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-1457778990.751368-27690497', '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 04:05:38 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 04:05:38 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 04:05:38 INFO - Using env: {'DISPLAY': ':0', 04:05:38 INFO - 'HOME': '/home/cltbld', 04:05:38 INFO - 'LANG': 'en_US.UTF-8', 04:05:38 INFO - 'LANGUAGE': 'en_US:en', 04:05:38 INFO - 'LOGNAME': 'cltbld', 04:05:38 INFO - 'MAIL': '/var/mail/cltbld', 04:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:38 INFO - 'MOZ_NO_REMOTE': '1', 04:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:38 INFO - 'NO_EM_RESTART': '1', 04:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:38 INFO - 'SHELL': '/bin/bash', 04:05:38 INFO - 'SHLVL': '1', 04:05:38 INFO - 'TERM': 'linux', 04:05:38 INFO - 'TMOUT': '86400', 04:05:38 INFO - 'USER': 'cltbld', 04:05:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:38 INFO - '_': '/tools/buildbot/bin/python'} 04:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:38 INFO - Downloading/unpacking flake8 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:38 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 04:05:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:05:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:05:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:41 INFO - no previously-included directories found matching 'docs/_build' 04:05:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:05:41 INFO - Running setup.py install for pep8 04:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:05:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:05:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:05:41 INFO - no previously-included directories found matching 'docs/_build' 04:05:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:05:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:05:41 INFO - Cleaning up... 04:05:41 INFO - Return code: 0 04:05:41 INFO - Running post-action listener: _resource_record_post_action 04:05:41 INFO - Running post-action listener: _start_resource_monitoring 04:05:41 INFO - Starting resource monitoring. 04:05:41 INFO - ##### 04:05:41 INFO - ##### Running install step. 04:05:41 INFO - ##### 04:05:41 INFO - Running pre-action listener: _resource_record_pre_action 04:05:41 INFO - Running main action method: install 04:05:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:05:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:05:41 INFO - Reading from file tmpfile_stdout 04:05:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:05:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:05:41 INFO - Reading from file tmpfile_stdout 04:05:41 INFO - Output received: 04:05:41 INFO - Usage: mozinstall [options] installer 04:05:41 INFO - Options: 04:05:41 INFO - -h, --help show this help message and exit 04:05:41 INFO - -d DEST, --destination=DEST 04:05:41 INFO - Directory to install application into. [default: 04:05:41 INFO - "/builds/slave/test-pgo"] 04:05:41 INFO - --app=APP Application being installed. [default: firefox] 04:05:41 INFO - mkdir: /builds/slave/test-pgo/build/application 04:05:41 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'] 04:05:41 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 04:05:58 INFO - Reading from file tmpfile_stdout 04:05:58 INFO - Output received: 04:05:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:05:58 INFO - Running post-action listener: _resource_record_post_action 04:05:58 INFO - ##### 04:05:58 INFO - ##### Running run-tests step. 04:05:58 INFO - ##### 04:05:58 INFO - Running pre-action listener: _resource_record_pre_action 04:05:58 INFO - Running main action method: run_tests 04:05:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:05:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:05:58 INFO - Python 2.7.3 04:05:58 INFO - Return code: 0 04:05:58 INFO - grabbing minidump binary from tooltool 04:05:58 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')]} 04:05:58 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 0x2778920>, '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 0x2779820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2779cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:05:58 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 04:05:58 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 04:05:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:58 INFO - Return code: 0 04:05:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:05:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:05:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:05:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:05:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:05:59 INFO - Return code: 0 04:05:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:59 INFO - Using env: {'DISPLAY': ':0', 04:05:59 INFO - 'HOME': '/home/cltbld', 04:05:59 INFO - 'LANG': 'en_US.UTF-8', 04:05:59 INFO - 'LANGUAGE': 'en_US:en', 04:05:59 INFO - 'LOGNAME': 'cltbld', 04:05:59 INFO - 'MAIL': '/var/mail/cltbld', 04:05:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:59 INFO - 'MOZ_NO_REMOTE': '1', 04:05:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:59 INFO - 'NO_EM_RESTART': '1', 04:05:59 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:59 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:05:59 INFO - 'SHELL': '/bin/bash', 04:05:59 INFO - 'SHLVL': '1', 04:05:59 INFO - 'TERM': 'linux', 04:05:59 INFO - 'TMOUT': '86400', 04:05:59 INFO - 'USER': 'cltbld', 04:05:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1457778990.751368-27690497', 04:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:59 INFO - '_': '/tools/buildbot/bin/python'} 04:05:59 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/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 04:05:59 INFO - mozversion application_buildid: 20160312013032 04:05:59 INFO - mozversion application_changeset: ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 04:05:59 INFO - mozversion application_display_name: Nightly 04:05:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:59 INFO - mozversion application_name: Firefox 04:05:59 INFO - mozversion application_remotingname: firefox 04:05:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:05:59 INFO - mozversion application_vendor: Mozilla 04:05:59 INFO - mozversion application_version: 48.0a1 04:05:59 INFO - mozversion platform_buildid: 20160312013032 04:05:59 INFO - mozversion platform_changeset: ba5dd6053cc4351e58ad407d8ef96a6dfcf344d4 04:05:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:05:59 INFO - mozversion platform_version: 48.0a1 04:05:59 INFO - using testdate: 1457784359 04:05:59 INFO - actual date: 1457784359 04:05:59 INFO - starting webserver on 'localhost:60483' 04:05:59 INFO - SUITE-START | Running 2 tests 04:05:59 INFO - TEST-START | dromaeo_css 04:05:59 INFO - operating with platform_type : linux_ 04:05:59 INFO - Initialising browser for dromaeo_css test... 04:05:59 INFO - TEST-INFO | started process 18278 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkIkA4P/profile http://localhost:60483/getInfo.html) 04:06:03 INFO - PROCESS | 18278 | __metrics Screen width/height:1600/1200 04:06:03 INFO - PROCESS | 18278 | colorDepth:24 04:06:03 INFO - PROCESS | 18278 | Browser inner width/height: 1024/697 04:06:03 INFO - PROCESS | 18278 | __metrics 04:06:04 ERROR - PROCESS | 18278 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:06:05 INFO - TEST-INFO | 18278: exit 0 04:06:05 INFO - Browser initialized. 04:06:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:05 INFO - TEST-INFO | started process 18369 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkIkA4P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:16 INFO - PROCESS | 18369 | RSS: Main: 152973312 04:06:16 INFO - PROCESS | 18369 | 04:07:08 INFO - PROCESS | 18369 | 1457784428491 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] 04:09:14 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60483/tests/dromaeo/cssquery-ext.html) 04:09:15 INFO - PROCESS | 18369 | RSS: Main: 277307392 04:09:15 INFO - PROCESS | 18369 | 04:12:18 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-ext.html (next: http://localhost:60483/tests/dromaeo/cssquery-jquery.html) 04:12:18 INFO - PROCESS | 18369 | RSS: Main: 235995136 04:12:18 INFO - PROCESS | 18369 | 04:15:20 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60483/tests/dromaeo/cssquery-mootools.html) 04:15:21 INFO - PROCESS | 18369 | RSS: Main: 233164800 04:15:21 INFO - PROCESS | 18369 | 04:18:22 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60483/tests/dromaeo/cssquery-prototype.html) 04:18:23 INFO - PROCESS | 18369 | RSS: Main: 219193344 04:18:23 INFO - PROCESS | 18369 | 04:21:25 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60483/tests/dromaeo/cssquery-yui.html) 04:21:26 INFO - PROCESS | 18369 | RSS: Main: 221020160 04:21:26 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | Cycle 1(1): loaded http://localhost:60483/tests/dromaeo/cssquery-yui.html (next: http://localhost:60483/tests/dromaeo/cssquery-dojo.html) 04:24:29 INFO - PROCESS | 18369 | RSS: Main: 263872512 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | __start_tp_report 04:24:29 INFO - PROCESS | 18369 | _x_x_mozilla_page_load 04:24:29 INFO - PROCESS | 18369 | _x_x_mozilla_page_load_details 04:24:29 INFO - PROCESS | 18369 | |i|pagename|runs| 04:24:29 INFO - PROCESS | 18369 | |0;dojo.html;3002.849857507125;3059.4340047091277;3080.2145452909504;3095.210721266078;3117.1895307220125;5049.899002019957;5183.17069268917;5203.635745497817;5224.138017227157;5231.503007214314;5155.329807125077;5199.376074871021;5208.166693329068;5217.634765566412;5249.553787928031;4607.746573938432;4609.815607375701;4717.646176536757;4767.928481072787;4774.021325628255;4597.977010114962;4679.649026323023;4737.265723812815;4743.667943243974;4852;4671.85984420468;4677.695949763254;4682.578567928886;4716.646251531149;4731.881702957419;4672.906541869178;4689.671722979393;4704.411948506437;4717.481077081518;4754.857354279377;4567.314902764579;4626.051659409813;4629.51390104041;4657.39453870998;4694.741789201593;5022.096022715909;5028.547430731215;5043.899122017576;5046.318746969186;5052.747362631853;5522.5581953443625;5545.694986775726;5590.18942253371;5591.133374326986;5595.4124816894455;5523.061079616475;5529.529989950859;5531.419200983919;5532.585056120807;5537.944620553783;5095.0574143783515;5139.434662187156;5141.074606570815;5147.150720131174;5185.974070129625;5551.555875529948;5603.579731520071;5681.289838770153;5739.7704091836695;5742.28221472316;5395.757190926418;5433.185022246695;5448.673079615157;5465.016297066566;5475.151351540518;5348.652337598043;5552.361478429952;5558.249636299129;5559.777608895599;5568.805091821767;5491.560675145979;5523.005858945348;5524.392316845144;5541.307336582927;5585.469380408936;5475.342958844884;5486.3690675572025;5487.64330318528;5505.9724701376235;5511.3937466878615;4118.155778065549;4190.706650534495;4229.97885010573;4236.025714085716;4263.955330943939;3787.034306251888;3791.4123310886857;3822.4266360046217;3829.7893615851394;3839.500864887547;5206.140986737221;5229.137192363293;5247.921281180786;5255.710935898563;5308.734563271821;5389.568834493231;5522.171674248814;5541.9168712469345;5553.8333849984565;5628.493435590816;5231.790728370898;5248.055350036953;5255.448177941337;5265.262863199156;5271.894562108736;4794;4811.663183577116;4817;4819.3012013257885;4834.7824347903725;5550.389457159709;5724.971375143097;5753.539716822645;5814.79648212319;5819.912701309484;5525.475079867487;5554.333479982266;5557.3331200256225;5557.916631250454;5559.972200138974;5742.827715168552;5759.7408116634015;5764.538836892954;5764.884702306014;5769.74036168365;5306.54894333986;5417.214503896992;5481.068218402801;5493.011257973603;5533.474319939599;5541.806036788693;5565.443455654402;5565.582581306499;5566.638168519034;5569.944300556943;5251.816186433456;5391.002664507078;5454.781808727606;5463.48096930791;5512.503874651301;5370.382406023357;5416.377116631637;5417.485338892799;5434.239206511171;5462.508374246337;5298;5301.072312345401;5307.548858347083;5315.202719592092;5323.547498462674;5250.763715632729;5414.783408663609;5432.29380180574;5434.510894019557;5435.320584926884;5121.8719532012;5296.602754793329;5309.309789727311;5339.572834173335;5377.247185394126 04:24:29 INFO - PROCESS | 18369 | |1;ext.html;556.6604322014242;580.5239703443176;582.7494177503673;593.7446897833935;602.0036839031403;38633.42049869251;38794.80602596987;38807.223855522876;38849.640262590816;38941.22117557647;40913.59086409135;41421.37867931984;41469.792651036776;41478;41491.792541037255;8607.139286071375;8854.955725221365;8866.42368246062;8870.290376769843;8880.200781929625;8617.61220745065;8777.253933415668;8789.47263164209;8977.506237156986;8985.236254918307;8996.730098097067;9084.8637270441;9086.091390860927;9097.408668436563;9100.408473449237;8906.332025098143;8961.103889611019;8973.416727912665;8990.280777537813;8994.685186018458;8888.511131887744;8997.190252877272;9012.188902998696;9013.819723605557;9015.27877769777;42029.36955945663;42580.57419425828;42626;42725.78637106826;42731.78634106841;3489.685928266468;3687.9262414751825;3712.201876596545;3990.7206495545324;4185.455890734215;32436.6756332436;32587.348253035045;32643.51034734457;32661.83669081663;32702.836485817657;3931;4113.91772164558;4134.04881632571;4170.207660544487;4199.223143718422;293280;295157.99999999785;295180;295969;296765;58777;58965;58983.41016589865;59437.40562594319;59511.404885950586;62142.37857621456;62338.68830655908;62376;62620;62663.373366265754;15513.84486155124;15738.134402607737;15750.291236894367;15770.369185232692;15772.68454630901;11592;11601.303921764722;11627.302361858316;11674.241174323812;11680.182387232811;18623.699951500876;19514.877619581082;19523.183968271933;19567.510812229808;19630.21479140847;6092.482139018144;7007.614581197981;7190.721520695178;7257.129144502694;7349.154847192534;1080.1790639114329;1106.6126855600637;1119.832025196227;1146.1461211397561;1207.3118322556059;29992.70007299943;30710;31619.84190079035;32563.348733025206;33083.834580827424;1094.7263184203948;1104.4919337104861;1105.0441368216434;1188.0495603517152;1209.9896586350496;16429.58926026859;16740.58148546296;16753.413630522875;16766.245518951677;16871.32514699423;399015;404274;405313;406098;406382;55070;55402.72298638481;55732.72133639306;55778;55805.37265077838;1213.1144264686652;1357.2060344698461;1360.435419300979;1361.2989310505097;1383.1286289637665;30285.242868928453;32022.67977320197;32309.838450807594;32357.191070223435;32837.34325313433;46563.740538162005;47566.52433475621;47588.2861757067;47596.52403475921;47624.809379764396;294563;306374;306610;306627;306875;41120;41753.79123104365;48660.5133948656;50134;50446;48899;48931.75534122449;50005;50257.24614130718;50688;38560.61439385683;38783.41824872573;39200.60799391969;39458.80270598744;40293.59706402898;41484.37773433341;41502.792486037375;42032.36951445792;42166.36750448684;43550.56449435592;41455;41792.58207417887;42378;42838.78580607077;42853.1429371417;36805.26389472249;37819.243615126994;37905.24189516249;38316.61683383131;38576.22847543089;29486.557701634923;29600.851995740744;29620.851895740383;29624.85187574048;29929.251768705955 04:24:29 INFO - PROCESS | 18369 | |2;jquery.html;344.552082293019;351.46226273801085;351.89091381671676;355.36389862146757;356.5311615225979;17569.1215439228;17702.555492259566;19680.704789428153;19741;19753.407397778054;17981.59270103631;18599.81400186001;19018.524536886584;19069.427917162506;19078.904605476953;5402.216678581603;5555.638883472581;5573.554115670737;5578.41426650202;5582.413846546095;3972.5828787977134;5449.4005659377435;5766.711664416784;5980.671063091529;6002.549808764338;5958;5958.433948774881;5965.821025369224;5979.2824861016525;5992.400759924017;5833.504152147073;5864.472197502224;5974.462298393122;5979.760809567612;6060.151578778975;3530.346885826105;5078.746062696888;5260.158374660036;5273.288106105665;5277.340332458442;21960.670589941165;22403.32790016302;22452.550948981094;22956.77043229563;22958.311250662508;2421.116292553223;2451.718052423976;2500.624906264057;2711.064682684471;2903.2016195546184;14013.5095271665;14126.50557230492;14137.434502619883;14234.715305693828;14584.416623335053;1923.1057558235489;2003.4590660521724;2008.5480766827493;2050.5693804301113;2102.6530622447276;67634.32365676378;69086.65456672735;69149.65425172843;69574.65212673905;70039;10196.898031019744;10350.637727679496;10470.790584188273;10563.260571760056;10655.73360665974;13509.392077356542;13578.524751633842;13579.117357371739;13580.320983950764;13591.796123058162;7429.2570742926355;7526.548407095592;7557.261829779181;7642;7656.425768067305;7116.146062472537;7182;7192.748253811092;7242.493025488166;7375.336219740249;6495.1556297681;6521.6413097279155;6556.868862622816;6565.474762019123;6569.605823650596;1642.2199455258656;1690.653416049707;1720.698877696398;1723.612187257857;1740.782402199725;964.8166848298941;1049.1606714628267;1108.1135091926587;1127.402476687357;1164.6098556983504;18536.536586585175;19248.326308579133;19262.614747705247;19337.463775357024;19657.705134422995;1029.5572903651503;1063.5214153630898;1076.5101878645198;1077.197487871525;1117.4859564600213;10918.50866711;11307.94346028281;11330.94334528322;11349.60276390339;11362.147838912115;462171;464013;466026;495551;537891;72446;73605.6319718398;74101;74314;74895.62552187205;965.9806803863743;1057;1069.9518521666544;1078.0890147825075;1081.9296745711504;16136.515904522883;16257.59356016109;16360.672786543964;16729;16730.749038764672;32626.347473049933;33641.831790840886;34038;34096.31807363888;34223;38764.80617596894;39466.802665986484;40852.79573602113;41128.38307425331;41368;7977.880331794911;8038.075621303391;8068.798280043045;8082.353411727166;8088.797780055545;13219.339033048502;13258.469661213443;13378.197308161542;13508.459661613819;13648.454061837416;6232.314445411092;7456.850862982818;10145.340552864336;10329.483525823529;11746.58886938953;11183.776324473627;11217;11556.364399958084;11595.942020289845;11660.30038197711;11886.702832429259;11974.580889669169;12048.939755301168;12122.515099396278;12291.508339666314;7288.161861385796;7471.775846724607;7554.924450755642;7573.318401343906;8302.584870756558;10731.517081731185;11924.582639607572;11956.641300760992;12003.63989080329;12204 04:24:29 INFO - PROCESS | 18369 | |3;mootools.html;1323.675699453634;1498.0412535976977;1507;1704.403458789424;1855.0446520042171;7645.235476452359;7798.454108212421;7816.491928024674;7823.3350165236025;7828.412869034817;7569.167391586935;7681.270279323469;7720.922790772091;7721.652525636346;7748.612569371523;1946.698261769428;1997.0414201183441;2198.604251234777;2225.7440394354653;2258.9209377671787;2225.1655629139073;2232.5423288225875;2233.62028455163;2235.8099561537288;2238.2278114050628;2168.8807115608633;2200.713907192063;2206.6138425775425;2208.8785116818567;2212.0045979309375;2166.620841352757;2206.481476852938;2209.9889500552554;2215.46828761097;2222.866628002325;2171.630822760119;2180.7710190430093;2182.454386403399;2190.5509370578993;2190.6385446401323;7862.921370786276;7928.722494712715;7930.167332430069;7947.920520794776;7952.085510166347;4717.787699553528;4818.325434439182;4849.369581954358;4851.442084160331;4852.1508735971065;3162.620485541727;3265.363254165439;3299.5215693724276;3310;3330.1841048943165;1043.12377602814;1047.879493858201;1075.172117469544;1082.5020490574266;1116.625930313346;10563.68308950725;10678.466076696212;10691.144708423308;10692.572297108185;10711.089557387631;4179.1432756284885;4201.621854033152;4316.611504964569;4320.675949303814;4329.415528903621;9360.063993600585;9380.765480863032;9442.763930901645;9717.416954982724;9725.173360264314;4976.601871850244;4993.525615066563;4996.675216110941;4997.225430058346;5001.4998500149695;3851.672607828366;4394.1870753910625;4490.50604433512;4497.168023915586;4512.684112112186;3730.0301921500063;3782.791946442972;3812.7331086823656;3815.771053736785;3849.615038496128;1138.7779383020397;1140.3841925360377;1140.7775483780583;1144.5707859552667;1149.8620165580185;1074.6937122920087;1083.0956151613334;1235.7034311765112;1415.0519152168072;1438.0293302021093;7354.96322518384;7472.364848987897;7494.812629684193;7685.116211635622;7693.576853273012;435.8823117758251;436.45225242321317;438.2309047621404;440.0956035347392;458.3926297655553;6052.54605904559;6110.144579758838;6112.449879510777;6119.84700382494;6151.907721384183;9102.089791020977;9601.855972160423;9673.661421850342;9690;9694.563744631509;9452.338336316392;9509;9610.66362677317;9640.71077867665;9647.855282170773;7394.371478424394;7540.962295188599;7615.5430674159725;7675.270849269311;7705.4220933430215;7274.963625182052;7410.147832999274;7429.294217049372;7440;7443.516171448839;8487.108853570286;8642;8809.647614095364;8831.161039701217;8857.734267971971;8385.413021088709;8918.598663060047;8922.420042697204;8939.374243802871;8951.149640784115;6296.2759282681245;6827.453803695593;7015.052967849275;7054.788356349318;7131.572105673677;7528.736494222676;7539.283768042027;7551.924480755122;7572.280633339824;7582.54504729718;6665.400113989765;6770.52606317553;6783.626900520519;6803.455723542006;6964.338387853146;6655.534112612071;6705.731770729116;6713.429358504582;6716.29478904708;6792.626405547742;7026.543274687129;7077.858442831218;7080.362767350963;7144.67848946809;7289.599072051088;6506.707198176188;6510.3489651034515;6540.640264785482;6553.770618028346;6566.212054553484;6653.234877989094;6702.564333318319;6703;6713.295104014008;6752.696128674123 04:24:29 INFO - PROCESS | 18369 | |4;prototype.html;302.72603294018904;305.3374178033667;308.1602632825551;308.70364450127863;309.9178717639824;5889.322727886294;5928.170056192132;5931.228940237774;5993.88012239755;5997.250343707036;5882.941170588293;5934.961381758197;5974.163617093611;5977.372375900533;5984.910226346608;4276.465441819772;4390.495093064291;4455.710378825383;4509.616682581968;4556.4760052593965;4485.618722408599;4497.123061003105;4503.864884053483;4506.8422605208825;4518.525554816746;4460.33095035744;4462.821487140511;4464.776761161929;4470.128324976631;4471.262241730111;4211.620954114129;4323.567643235683;4411.558844115595;4412.624926881219;4419.049904270565;3797.2025874566375;3804.6766024887916;3805.315043292206;3817.770933743984;3818.5417749870194;5642.322921249476;5644.689542075184;5647.689377084259;5650.265465489501;5650.434956504317;5097.745112744348;5100.336956195708;5103.157978933472;5104.055749686283;5104.285400043959;6119.479844213247;6138.938610613882;6146.17026701394;6157.661328626924;6176.042713379434;4093;4203.600657937491;4218.346156345771;4220.85227017056;4225.830966761326;6465.77369792055;6493.837654058639;6515.02274658805;6516.902246466307;6522.249941256769;4285.142971405669;4289.1636130954785;4290.613844753987;4293.742375457483;4313.870583882489;4326.480822301344;4368.126374725068;4368.191884501377;4371;4372.147431250875;5076.416212135578;5085.9745701271995;5092.0579692756955;5092.337996060563;5097.949020509747;6236.937630623726;6251.28110267316;6253.093301471261;6255.374462553708;6258.186435763413;1483;1515.053091817614;1517.2034681792147;1517.5750789778879;1518.3471107423914;949.0414681172066;973.522973742875;984.4093543873619;1004.864343313658;1022.4989755019986;5938.465538101592;5952.9107063394085;5985.581009329392;5999.610025348338;6006.969965150146;6347.841303967345;6366.649834259068;6366.872662546723;6372.299047104815;6378.234611846516;5965.910511342333;5972.671503067286;5982.252218472691;5985.6408615483215;5987.491063259585;3397.4394224952607;3429.416999110157;3433.639467855889;3435;3435.811030393302;6479.6760161991715;6635.734570617218;6639.136912201383;6657.1012913257055;6659.6670166491485;6455.61266324022;6473.77341793035;6491.221053473613;6510.08858759774;6518.217813862367;6640.734370625121;6643.169603799525;6645.1361323027695;6649.135612370457;6652.833679158157;6357.237131544244;6364.809055728336;6365.8726825464155;6369.172007638977;6372.07604897278;6188.1027251049245;6249.500039996698;6281;6289.308176100534;6364.045393190873;6752.527323087534;6768.661566921536;6769.289224631343;6786.151731033621;6793.048973143665;4386.035072284092;4419.13826803783;4423.778811059498;4429.180601588717;4430.534793846599;6441.581297215666;6459.806205813833;6466.094746735367;6466.935330646822;6475.320091390525;6280.057991301342;6295.213098362705;6311.305756366704;6314.084457753508;6319.304876463493;6053.424924632153;6205.844853878689;6206.10011548332;6212.0371342441995;6218.440340369389;6082.60463069899;6094.7257373417415;6115.877682446415;6118.552578968448;6174.228221472316;6318.05229215603;6318.462930650946;6319.083732858801;6322.525810564134;6325;5878.559108066997;5997.730102145327;6114.816555503342;6161.661108638888;6176.598521096114 04:24:29 INFO - PROCESS | 18369 | |5;yui.html;754.4718696912163;756.2210922749566;814.1532805881882;835.3985130705889;895.5611750242381;14554.12675239485;14699;14723.337449814757;14734.18961957092;14876.925615371922;13291.800622990662;14034.087784294014;14203.71592568148;14228.07517511361;14248.358823852926;696.3245651717825;838.4298676899706;854.2098558833086;871.1071152069117;875.544716747291;860.0625318402939;865;865.0138841720412;865.7359505350897;866.536403024382;911.5715613661602;911.8677791720197;914.0356923445762;914.1681070226095;915.1489115122934;722.3895808042196;885.9379843410964;899.6446403670514;899.9640014399416;901.1394118616705;659.3307792590524;660.1055569703032;660.3990368764402;661.3518751623388;661.4146480364864;14699.338529766079;14744.115353078849;14762.70474590502;14777.7783333249;14780.187089710169;13594.524191653343;13793.931030344884;13891.235982020984;13982.510612128628;14872;11159.553617855276;11387.08903287735;11493.885061149365;11536.538538458452;11609.593664221711;4516.254817955033;4600.4479462464715;4640.883977900579;4738.857834264978;4756.215224487955;49328.50671493275;49469.99999999964;49937;50353.49646503525;50384.496155038716;11159.330440173615;11168.609098681507;11355.26190797612;11428.599998999995;11481.71295717597;18281.81718182828;18300.633987320445;18312.267509299745;18318.725219121723;18320.725189122175;8201.79495512617;8274.379421543408;8405.369597280229;8618.827623447622;8635.525046122524;4682;4845.127876982177;4872.512748725099;4896.045271172158;5032.094223039888;3287.474004159323;3321.0534997525588;3322.2358857462436;3324.900252992414;3333.0500807269814;514.269736973491;599.6701814002281;601.4526780629606;657.4970147836908;665.3346653346654;666.7666316789085;752.2702978111223;783.2989474420361;791.4459878085363;804.4489524675616;9047.728568142966;9331.813363732688;9565.426074435556;9638.373505722106;9742;775.309974123031;789.1989630525022;792.7502836606451;805.452292441134;819.1562690428868;4467.539679784962;4544.409226800495;4605.953940460619;4615.5845973862515;4649.86050418488;64169.35830641634;64757;65046.34953650403;65066;65587;58528;58574;58877;59027.40972590305;63173.684131579044;48561.514384856404;48689.513104869206;49353;49424.75287623539;50255.497445025816;10053.597856085675;10067.546960386946;10094;10098.848517272394;10115.949420252851;40134;40715.79642101771;40774.59225407708;41428.58571414247;41854.16291674088;49439.752801235765;52297;52489.737551312;52517.7374113127;53385;12418.192817466836;12840.743185136433;12988;13202.943764499008;13220.537281195113;13869.583912482642;14082.577522674335;14255.857441425453;14623.195724234844;15014.6997060056;13362.532311369445;13410.396532156272;13496.797548036591;13872.4451021958;13921.721565568429;13033.15284506504;13076;13127.146735462164;13351.532696355582;13978.65053373633;13352.599422017354;13482.595522134352;13977.510787122403;14027.438902443788;14317.498887538886;11126.221164518405;11214.439278035903;11327.15046371509;11420.200585958903;11546;11241.381724005258;11334.206605537533;11413.885861141282;11462.254953428;11684.357360345262 04:24:29 INFO - PROCESS | 18369 | __end_tp_report 04:24:29 INFO - PROCESS | 18369 | __start_cc_report 04:24:29 INFO - PROCESS | 18369 | _x_x_mozilla_cycle_collect,925 04:24:29 INFO - PROCESS | 18369 | __end_cc_report 04:24:29 INFO - PROCESS | 18369 | __startTimestamp1457785469398__endTimestamp 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | ------- Summary: start ------- 04:24:29 INFO - PROCESS | 18369 | Number of tests: 6 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#0] dojo.html Cycles:165 Average:5139.11 Median:5308.73 stddev:575.79 (10.8%) stddev-sans-first:552.63 04:24:29 INFO - PROCESS | 18369 | Values: 3002.8 3059.4 3080.2 3095.2 3117.2 5049.9 5183.2 5203.6 5224.1 5231.5 5155.3 5199.4 5208.2 5217.6 5249.6 4607.7 4609.8 4717.6 4767.9 4774.0 4598.0 4679.6 4737.3 4743.7 4852.0 4671.9 4677.7 4682.6 4716.6 4731.9 4672.9 4689.7 4704.4 4717.5 4754.9 4567.3 4626.1 4629.5 4657.4 4694.7 5022.1 5028.5 5043.9 5046.3 5052.7 5522.6 5545.7 5590.2 5591.1 5595.4 5523.1 5529.5 5531.4 5532.6 5537.9 5095.1 5139.4 5141.1 5147.2 5186.0 5551.6 5603.6 5681.3 5739.8 5742.3 5395.8 5433.2 5448.7 5465.0 5475.2 5348.7 5552.4 5558.2 5559.8 5568.8 5491.6 5523.0 5524.4 5541.3 5585.5 5475.3 5486.4 5487.6 5506.0 5511.4 4118.2 4190.7 4230.0 4236.0 4264.0 3787.0 3791.4 3822.4 3829.8 3839.5 5206.1 5229.1 5247.9 5255.7 5308.7 5389.6 5522.2 5541.9 5553.8 5628.5 5231.8 5248.1 5255.4 5265.3 5271.9 4794.0 4811.7 4817.0 4819.3 4834.8 5550.4 5725.0 5753.5 5814.8 5819.9 5525.5 5554.3 5557.3 5557.9 5560.0 5742.8 5759.7 5764.5 5764.9 5769.7 5306.5 5417.2 5481.1 5493.0 5533.5 5541.8 5565.4 5565.6 5566.6 5569.9 5251.8 5391.0 5454.8 5463.5 5512.5 5370.4 5416.4 5417.5 5434.2 5462.5 5298.0 5301.1 5307.5 5315.2 5323.5 5250.8 5414.8 5432.3 5434.5 5435.3 5121.9 5296.6 5309.3 5339.6 5377.2 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#1] ext.html Cycles:180 Average:51712.31 Median:41016.80 stddev:88644.08 (216.1%) stddev-sans-first:88809.54 04:24:29 INFO - PROCESS | 18369 | Values: 556.7 580.5 582.7 593.7 602.0 38633.4 38794.8 38807.2 38849.6 38941.2 40913.6 41421.4 41469.8 41478.0 41491.8 8607.1 8855.0 8866.4 8870.3 8880.2 8617.6 8777.3 8789.5 8977.5 8985.2 8996.7 9084.9 9086.1 9097.4 9100.4 8906.3 8961.1 8973.4 8990.3 8994.7 8888.5 8997.2 9012.2 9013.8 9015.3 42029.4 42580.6 42626.0 42725.8 42731.8 3489.7 3687.9 3712.2 3990.7 4185.5 32436.7 32587.3 32643.5 32661.8 32702.8 3931.0 4113.9 4134.0 4170.2 4199.2 293280.0 295158.0 295180.0 295969.0 296765.0 58777.0 58965.0 58983.4 59437.4 59511.4 62142.4 62338.7 62376.0 62620.0 62663.4 15513.8 15738.1 15750.3 15770.4 15772.7 11592.0 11601.3 11627.3 11674.2 11680.2 18623.7 19514.9 19523.2 19567.5 19630.2 6092.5 7007.6 7190.7 7257.1 7349.2 1080.2 1106.6 1119.8 1146.1 1207.3 29992.7 30710.0 31619.8 32563.3 33083.8 1094.7 1104.5 1105.0 1188.0 1210.0 16429.6 16740.6 16753.4 16766.2 16871.3 399015.0 404274.0 405313.0 406098.0 406382.0 55070.0 55402.7 55732.7 55778.0 55805.4 1213.1 1357.2 1360.4 1361.3 1383.1 30285.2 32022.7 32309.8 32357.2 32837.3 46563.7 47566.5 47588.3 47596.5 47624.8 294563.0 306374.0 306610.0 306627.0 306875.0 41120.0 41753.8 48660.5 50134.0 50446.0 48899.0 48931.8 50005.0 50257.2 50688.0 38560.6 38783.4 39200.6 39458.8 40293.6 41484.4 41502.8 42032.4 42166.4 43550.6 41455.0 41792.6 42378.0 42838.8 42853.1 36805.3 37819.2 37905.2 38316.6 38576.2 29486.6 29600.9 29620.9 29624.9 29929.3 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#2] jquery.html Cycles:180 Average:27221.80 Median:12689.71 stddev:79476.20 (626.3%) stddev-sans-first:79673.53 04:24:29 INFO - PROCESS | 18369 | Values: 344.6 351.5 351.9 355.4 356.5 17569.1 17702.6 19680.7 19741.0 19753.4 17981.6 18599.8 19018.5 19069.4 19078.9 5402.2 5555.6 5573.6 5578.4 5582.4 3972.6 5449.4 5766.7 5980.7 6002.5 5958.0 5958.4 5965.8 5979.3 5992.4 5833.5 5864.5 5974.5 5979.8 6060.2 3530.3 5078.7 5260.2 5273.3 5277.3 21960.7 22403.3 22452.6 22956.8 22958.3 2421.1 2451.7 2500.6 2711.1 2903.2 14013.5 14126.5 14137.4 14234.7 14584.4 1923.1 2003.5 2008.5 2050.6 2102.7 67634.3 69086.7 69149.7 69574.7 70039.0 10196.9 10350.6 10470.8 10563.3 10655.7 13509.4 13578.5 13579.1 13580.3 13591.8 7429.3 7526.5 7557.3 7642.0 7656.4 7116.1 7182.0 7192.7 7242.5 7375.3 6495.2 6521.6 6556.9 6565.5 6569.6 1642.2 1690.7 1720.7 1723.6 1740.8 964.8 1049.2 1108.1 1127.4 1164.6 18536.5 19248.3 19262.6 19337.5 19657.7 1029.6 1063.5 1076.5 1077.2 1117.5 10918.5 11307.9 11330.9 11349.6 11362.1 462171.0 464013.0 466026.0 495551.0 537891.0 72446.0 73605.6 74101.0 74314.0 74895.6 966.0 1057.0 1070.0 1078.1 1081.9 16136.5 16257.6 16360.7 16729.0 16730.7 32626.3 33641.8 34038.0 34096.3 34223.0 38764.8 39466.8 40852.8 41128.4 41368.0 7977.9 8038.1 8068.8 8082.4 8088.8 13219.3 13258.5 13378.2 13508.5 13648.5 6232.3 7456.9 10145.3 10329.5 11746.6 11183.8 11217.0 11556.4 11595.9 11660.3 11886.7 11974.6 12048.9 12122.5 12291.5 7288.2 7471.8 7554.9 7573.3 8302.6 10731.5 11924.6 11956.6 12003.6 12204.0 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#3] mootools.html Cycles:180 Average:5531.29 Median:6401.49 stddev:2916.05 (45.6%) stddev-sans-first:2907.08 04:24:29 INFO - PROCESS | 18369 | Values: 1323.7 1498.0 1507.0 1704.4 1855.0 7645.2 7798.5 7816.5 7823.3 7828.4 7569.2 7681.3 7720.9 7721.7 7748.6 1946.7 1997.0 2198.6 2225.7 2258.9 2225.2 2232.5 2233.6 2235.8 2238.2 2168.9 2200.7 2206.6 2208.9 2212.0 2166.6 2206.5 2210.0 2215.5 2222.9 2171.6 2180.8 2182.5 2190.6 2190.6 7862.9 7928.7 7930.2 7947.9 7952.1 4717.8 4818.3 4849.4 4851.4 4852.2 3162.6 3265.4 3299.5 3310.0 3330.2 1043.1 1047.9 1075.2 1082.5 1116.6 10563.7 10678.5 10691.1 10692.6 10711.1 4179.1 4201.6 4316.6 4320.7 4329.4 9360.1 9380.8 9442.8 9717.4 9725.2 4976.6 4993.5 4996.7 4997.2 5001.5 3851.7 4394.2 4490.5 4497.2 4512.7 3730.0 3782.8 3812.7 3815.8 3849.6 1138.8 1140.4 1140.8 1144.6 1149.9 1074.7 1083.1 1235.7 1415.1 1438.0 7355.0 7472.4 7494.8 7685.1 7693.6 435.9 436.5 438.2 440.1 458.4 6052.5 6110.1 6112.4 6119.8 6151.9 9102.1 9601.9 9673.7 9690.0 9694.6 9452.3 9509.0 9610.7 9640.7 9647.9 7394.4 7541.0 7615.5 7675.3 7705.4 7275.0 7410.1 7429.3 7440.0 7443.5 8487.1 8642.0 8809.6 8831.2 8857.7 8385.4 8918.6 8922.4 8939.4 8951.1 6296.3 6827.5 7015.1 7054.8 7131.6 7528.7 7539.3 7551.9 7572.3 7582.5 6665.4 6770.5 6783.6 6803.5 6964.3 6655.5 6705.7 6713.4 6716.3 6792.6 7026.5 7077.9 7080.4 7144.7 7289.6 6506.7 6510.3 6540.6 6553.8 6566.2 6653.2 6702.6 6703.0 6713.3 6752.7 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#4] prototype.html Cycles:180 Average:5184.44 Median:5985.25 stddev:1593.28 (26.6%) stddev-sans-first:1555.05 04:24:29 INFO - PROCESS | 18369 | Values: 302.7 305.3 308.2 308.7 309.9 5889.3 5928.2 5931.2 5993.9 5997.3 5882.9 5935.0 5974.2 5977.4 5984.9 4276.5 4390.5 4455.7 4509.6 4556.5 4485.6 4497.1 4503.9 4506.8 4518.5 4460.3 4462.8 4464.8 4470.1 4471.3 4211.6 4323.6 4411.6 4412.6 4419.0 3797.2 3804.7 3805.3 3817.8 3818.5 5642.3 5644.7 5647.7 5650.3 5650.4 5097.7 5100.3 5103.2 5104.1 5104.3 6119.5 6138.9 6146.2 6157.7 6176.0 4093.0 4203.6 4218.3 4220.9 4225.8 6465.8 6493.8 6515.0 6516.9 6522.2 4285.1 4289.2 4290.6 4293.7 4313.9 4326.5 4368.1 4368.2 4371.0 4372.1 5076.4 5086.0 5092.1 5092.3 5097.9 6236.9 6251.3 6253.1 6255.4 6258.2 1483.0 1515.1 1517.2 1517.6 1518.3 949.0 973.5 984.4 1004.9 1022.5 5938.5 5952.9 5985.6 5999.6 6007.0 6347.8 6366.6 6366.9 6372.3 6378.2 5965.9 5972.7 5982.3 5985.6 5987.5 3397.4 3429.4 3433.6 3435.0 3435.8 6479.7 6635.7 6639.1 6657.1 6659.7 6455.6 6473.8 6491.2 6510.1 6518.2 6640.7 6643.2 6645.1 6649.1 6652.8 6357.2 6364.8 6365.9 6369.2 6372.1 6188.1 6249.5 6281.0 6289.3 6364.0 6752.5 6768.7 6769.3 6786.2 6793.0 4386.0 4419.1 4423.8 4429.2 4430.5 6441.6 6459.8 6466.1 6466.9 6475.3 6280.1 6295.2 6311.3 6314.1 6319.3 6053.4 6205.8 6206.1 6212.0 6218.4 6082.6 6094.7 6115.9 6118.6 6174.2 6318.1 6318.5 6319.1 6322.5 6325.0 5878.6 5997.7 6114.8 6161.7 6176.6 04:24:29 INFO - PROCESS | 18369 | 04:24:29 INFO - PROCESS | 18369 | [#5] yui.html Cycles:180 Average:15516.31 Median:4628.23 stddev:17818.54 (385.0%) stddev-sans-first:17834.04 04:24:29 INFO - PROCESS | 18369 | Values: 754.5 756.2 814.2 835.4 895.6 14554.1 14699.0 14723.3 14734.2 14876.9 13291.8 14034.1 14203.7 14228.1 14248.4 696.3 838.4 854.2 871.1 875.5 860.1 865.0 865.0 865.7 866.5 911.6 911.9 914.0 914.2 915.1 722.4 885.9 899.6 900.0 901.1 659.3 660.1 660.4 661.4 661.4 14699.3 14744.1 14762.7 14777.8 14780.2 13594.5 13793.9 13891.2 13982.5 14872.0 11159.6 11387.1 11493.9 11536.5 11609.6 4516.3 4600.4 4640.9 4738.9 4756.2 49328.5 49470.0 49937.0 50353.5 50384.5 11159.3 11168.6 11355.3 11428.6 11481.7 18281.8 18300.6 18312.3 18318.7 18320.7 8201.8 8274.4 8405.4 8618.8 8635.5 4682.0 4845.1 4872.5 4896.0 5032.1 3287.5 3321.1 3322.2 3324.9 3333.1 514.3 599.7 601.5 657.5 665.3 666.8 752.3 783.3 791.4 804.4 9047.7 9331.8 9565.4 9638.4 9742.0 775.3 789.2 792.8 805.5 819.2 4467.5 4544.4 4606.0 4615.6 4649.9 64169.4 64757.0 65046.3 65066.0 65587.0 58528.0 58574.0 58877.0 59027.4 63173.7 48561.5 48689.5 49353.0 49424.8 50255.5 10053.6 10067.5 10094.0 10098.8 10115.9 40134.0 40715.8 40774.6 41428.6 41854.2 49439.8 52297.0 52489.7 52517.7 53385.0 12418.2 12840.7 12988.0 13202.9 13220.5 13869.6 14082.6 14255.9 14623.2 15014.7 13362.5 13410.4 13496.8 13872.4 13921.7 13033.2 13076.0 13127.1 13351.5 13978.7 13352.6 13482.6 13977.5 14027.4 14317.5 11126.2 11214.4 11327.2 11420.2 11546.0 11241.4 11334.2 11413.9 11462.3 11684.4 04:24:29 INFO - PROCESS | 18369 | -------- Summary: end -------- 04:24:29 INFO - PROCESS | 18369 | 04:24:30 INFO - TEST-INFO | 18369: exit 0 04:24:30 INFO - TEST-OK | dromaeo_css | took 1110529ms 04:24:30 INFO - TEST-START | kraken 04:24:30 INFO - operating with platform_type : linux_ 04:24:30 INFO - Initialising browser for kraken test... 04:24:30 INFO - TEST-INFO | started process 18551 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuvMVd/profile http://localhost:60483/getInfo.html) 04:24:34 INFO - PROCESS | 18551 | __metrics Screen width/height:1600/1200 04:24:34 INFO - PROCESS | 18551 | colorDepth:24 04:24:34 INFO - PROCESS | 18551 | Browser inner width/height: 1024/697 04:24:34 INFO - PROCESS | 18551 | __metrics 04:24:34 ERROR - PROCESS | 18551 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:24:35 INFO - TEST-INFO | 18551: exit 0 04:24:35 INFO - Browser initialized. 04:24:35 INFO - Running cycle 1/1 for kraken test... 04:24:35 INFO - TEST-INFO | started process 18636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuvMVd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:47 INFO - PROCESS | 18636 | RSS: Main: 152457216 04:24:47 INFO - PROCESS | 18636 | 04:24:50 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60483/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:50 INFO - PROCESS | 18636 | RSS: Main: 192749568 04:24:50 INFO - PROCESS | 18636 | 04:24:53 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60483/tests/kraken/driver.html?testName=audio-dft) 04:24:53 INFO - PROCESS | 18636 | RSS: Main: 183357440 04:24:53 INFO - PROCESS | 18636 | 04:24:56 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60483/tests/kraken/driver.html?testName=audio-fft) 04:24:57 INFO - PROCESS | 18636 | RSS: Main: 168648704 04:24:57 INFO - PROCESS | 18636 | 04:24:59 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60483/tests/kraken/driver.html?testName=audio-oscillator) 04:24:59 INFO - PROCESS | 18636 | RSS: Main: 170823680 04:24:59 INFO - PROCESS | 18636 | 04:25:02 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:02 INFO - PROCESS | 18636 | RSS: Main: 173723648 04:25:02 INFO - PROCESS | 18636 | 04:25:05 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60483/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:06 INFO - PROCESS | 18636 | RSS: Main: 174092288 04:25:06 INFO - PROCESS | 18636 | 04:25:09 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60483/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:10 INFO - PROCESS | 18636 | RSS: Main: 173346816 04:25:10 INFO - PROCESS | 18636 | 04:25:12 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60483/tests/kraken/driver.html?testName=json-parse-financial) 04:25:13 INFO - PROCESS | 18636 | RSS: Main: 174678016 04:25:13 INFO - PROCESS | 18636 | 04:25:15 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:15 INFO - PROCESS | 18636 | RSS: Main: 185704448 04:25:15 INFO - PROCESS | 18636 | 04:25:17 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:17 INFO - PROCESS | 18636 | RSS: Main: 181166080 04:25:17 INFO - PROCESS | 18636 | 04:25:19 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:20 INFO - PROCESS | 18636 | RSS: Main: 194584576 04:25:20 INFO - PROCESS | 18636 | 04:25:22 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:23 INFO - PROCESS | 18636 | RSS: Main: 201506816 04:25:23 INFO - PROCESS | 18636 | 04:25:25 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:26 INFO - PROCESS | 18636 | RSS: Main: 201461760 04:25:26 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | Cycle 1(1): loaded http://localhost:60483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60483/tests/kraken/driver.html?testName=ai-astar) 04:25:28 INFO - PROCESS | 18636 | RSS: Main: 261259264 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | __start_tp_report 04:25:28 INFO - PROCESS | 18636 | _x_x_mozilla_page_load 04:25:28 INFO - PROCESS | 18636 | _x_x_mozilla_page_load_details 04:25:28 INFO - PROCESS | 18636 | |i|pagename|runs| 04:25:28 INFO - PROCESS | 18636 | |0;ai-astar;110;110;104;110;110;111;100;111;111;109 04:25:28 INFO - PROCESS | 18636 | |1;audio-beat-detection;146;124;148;166;126;149;156;128;172;125 04:25:28 INFO - PROCESS | 18636 | |2;audio-dft;162;160;161;160;160;160;161;163;160;163 04:25:28 INFO - PROCESS | 18636 | |3;audio-fft;73;76;96;96;74;75;76;108;99;75 04:25:28 INFO - PROCESS | 18636 | |4;audio-oscillator;93;93;147;92;92;92;139;92;93;142 04:25:28 INFO - PROCESS | 18636 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;116;117 04:25:28 INFO - PROCESS | 18636 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;146 04:25:28 INFO - PROCESS | 18636 | |7;imaging-desaturate;96;96;95;96;96;95;95;96;96;95 04:25:28 INFO - PROCESS | 18636 | |8;json-parse-financial;55;56;62;56;55;55;56;66;53;53 04:25:28 INFO - PROCESS | 18636 | |9;json-stringify-tinderbox;60;61;60;60;61;61;61;60;61;61 04:25:28 INFO - PROCESS | 18636 | |10;stanford-crypto-aes;76;77;77;77;77;78;78;78;78;80 04:25:28 INFO - PROCESS | 18636 | |11;stanford-crypto-ccm;108;110;111;110;106;120;107;118;113;113 04:25:28 INFO - PROCESS | 18636 | |12;stanford-crypto-pbkdf2;138;147;140;142;140;128;142;142;143;139 04:25:28 INFO - PROCESS | 18636 | |13;stanford-crypto-sha256-iterative;61;62;61;67;63;61;63;63;61;61 04:25:28 INFO - PROCESS | 18636 | __end_tp_report 04:25:28 INFO - PROCESS | 18636 | __start_cc_report 04:25:28 INFO - PROCESS | 18636 | _x_x_mozilla_cycle_collect,994 04:25:28 INFO - PROCESS | 18636 | __end_cc_report 04:25:28 INFO - PROCESS | 18636 | __startTimestamp1457785528395__endTimestamp 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | ------- Summary: start ------- 04:25:28 INFO - PROCESS | 18636 | Number of tests: 14 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.66 (3.3%) stddev-sans-first:3.84 04:25:28 INFO - PROCESS | 18636 | Values: 110.0 110.0 104.0 110.0 110.0 111.0 100.0 111.0 111.0 109.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:148.50 stddev:17.63 (11.9%) stddev-sans-first:18.69 04:25:28 INFO - PROCESS | 18636 | Values: 146.0 124.0 148.0 166.0 126.0 149.0 156.0 128.0 172.0 125.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 04:25:28 INFO - PROCESS | 18636 | Values: 162.0 160.0 161.0 160.0 160.0 160.0 161.0 163.0 160.0 163.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:13.31 (17.5%) stddev-sans-first:13.41 04:25:28 INFO - PROCESS | 18636 | Values: 73.0 76.0 96.0 96.0 74.0 75.0 76.0 108.0 99.0 75.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.00 stddev:24.35 (26.5%) stddev-sans-first:25.25 04:25:28 INFO - PROCESS | 18636 | Values: 93.0 93.0 147.0 92.0 92.0 92.0 139.0 92.0 93.0 142.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:25:28 INFO - PROCESS | 18636 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 04:25:28 INFO - PROCESS | 18636 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:25:28 INFO - PROCESS | 18636 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:4.11 (7.3%) stddev-sans-first:4.31 04:25:28 INFO - PROCESS | 18636 | Values: 55.0 56.0 62.0 56.0 55.0 55.0 56.0 66.0 53.0 53.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:25:28 INFO - PROCESS | 18636 | Values: 60.0 61.0 60.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:78.00 stddev:1.07 (1.4%) stddev-sans-first:0.97 04:25:28 INFO - PROCESS | 18636 | Values: 76.0 77.0 77.0 77.0 77.0 78.0 78.0 78.0 78.0 80.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#11] stanford-crypto-ccm Cycles:10 Average:111.60 Median:112.00 stddev:4.55 (4.1%) stddev-sans-first:4.64 04:25:28 INFO - PROCESS | 18636 | Values: 108.0 110.0 111.0 110.0 106.0 120.0 107.0 118.0 113.0 113.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:142.00 stddev:4.93 (3.5%) stddev-sans-first:5.17 04:25:28 INFO - PROCESS | 18636 | Values: 138.0 147.0 140.0 142.0 140.0 128.0 142.0 142.0 143.0 139.0 04:25:28 INFO - PROCESS | 18636 | 04:25:28 INFO - PROCESS | 18636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.89 (3.0%) stddev-sans-first:1.94 04:25:28 INFO - PROCESS | 18636 | Values: 61.0 62.0 61.0 67.0 63.0 61.0 63.0 63.0 61.0 61.0 04:25:28 INFO - PROCESS | 18636 | -------- Summary: end -------- 04:25:28 INFO - PROCESS | 18636 | 04:25:29 INFO - TEST-INFO | 18636: exit 0 04:25:29 INFO - TEST-OK | kraken | took 59232ms 04:25:29 INFO - SUITE-END | took 1169s 04:25:29 INFO - Completed test suite (00:19:29) 04:25:29 INFO - javascript benchmark 04:25:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3002.849857507125, 3059.4340047091277, 3080.2145452909504, 3095.210721266078, 3117.1895307220125, 5049.899002019957, 5183.17069268917, 5203.635745497817, 5224.138017227157, 5231.503007214314, 5155.329807125077, 5199.376074871021, 5208.166693329068, 5217.634765566412, 5249.553787928031, 4607.746573938432, 4609.815607375701, 4717.646176536757, 4767.928481072787, 4774.021325628255, 4597.977010114962, 4679.649026323023, 4737.265723812815, 4743.667943243974, 4852.0, 4671.85984420468, 4677.695949763254, 4682.578567928886, 4716.646251531149, 4731.881702957419, 4672.906541869178, 4689.671722979393, 4704.411948506437, 4717.481077081518, 4754.857354279377, 4567.314902764579, 4626.051659409813, 4629.51390104041, 4657.39453870998, 4694.741789201593, 5022.096022715909, 5028.547430731215, 5043.899122017576, 5046.318746969186, 5052.747362631853, 5522.5581953443625, 5545.694986775726, 5590.18942253371, 5591.133374326986, 5595.4124816894455, 5523.061079616475, 5529.529989950859, 5531.419200983919, 5532.585056120807, 5537.944620553783, 5095.0574143783515, 5139.434662187156, 5141.074606570815, 5147.150720131174, 5185.974070129625, 5551.555875529948, 5603.579731520071, 5681.289838770153, 5739.7704091836695, 5742.28221472316, 5395.757190926418, 5433.185022246695, 5448.673079615157, 5465.016297066566, 5475.151351540518, 5348.652337598043, 5552.361478429952, 5558.249636299129, 5559.777608895599, 5568.805091821767, 5491.560675145979, 5523.005858945348, 5524.392316845144, 5541.307336582927, 5585.469380408936, 5475.342958844884, 5486.3690675572025, 5487.64330318528, 5505.9724701376235, 5511.3937466878615, 4118.155778065549, 4190.706650534495, 4229.97885010573, 4236.025714085716, 4263.955330943939, 3787.034306251888, 3791.4123310886857, 3822.4266360046217, 3829.7893615851394, 3839.500864887547, 5206.140986737221, 5229.137192363293, 5247.921281180786, 5255.710935898563, 5308.734563271821, 5389.568834493231, 5522.171674248814, 5541.9168712469345, 5553.8333849984565, 5628.493435590816, 5231.790728370898, 5248.055350036953, 5255.448177941337, 5265.262863199156, 5271.894562108736, 4794.0, 4811.663183577116, 4817.0, 4819.3012013257885, 4834.7824347903725, 5550.389457159709, 5724.971375143097, 5753.539716822645, 5814.79648212319, 5819.912701309484, 5525.475079867487, 5554.333479982266, 5557.3331200256225, 5557.916631250454, 5559.972200138974, 5742.827715168552, 5759.7408116634015, 5764.538836892954, 5764.884702306014, 5769.74036168365, 5306.54894333986, 5417.214503896992, 5481.068218402801, 5493.011257973603, 5533.474319939599, 5541.806036788693, 5565.443455654402, 5565.582581306499, 5566.638168519034, 5569.944300556943, 5251.816186433456, 5391.002664507078, 5454.781808727606, 5463.48096930791, 5512.503874651301, 5370.382406023357, 5416.377116631637, 5417.485338892799, 5434.239206511171, 5462.508374246337, 5298.0, 5301.072312345401, 5307.548858347083, 5315.202719592092, 5323.547498462674, 5250.763715632729, 5414.783408663609, 5432.29380180574, 5434.510894019557, 5435.320584926884, 5121.8719532012, 5296.602754793329, 5309.309789727311, 5339.572834173335, 5377.247185394126], "unit": "score", "name": "dojo.html", "value": 5101.3289393271925}, {"lowerIsBetter": false, "replicates": [556.6604322014242, 580.5239703443176, 582.7494177503673, 593.7446897833935, 602.0036839031403, 38633.42049869251, 38794.80602596987, 38807.223855522876, 38849.640262590816, 38941.22117557647, 40913.59086409135, 41421.37867931984, 41469.792651036776, 41478.0, 41491.792541037255, 8607.139286071375, 8854.955725221365, 8866.42368246062, 8870.290376769843, 8880.200781929625, 8617.61220745065, 8777.253933415668, 8789.47263164209, 8977.506237156986, 8985.236254918307, 8996.730098097067, 9084.8637270441, 9086.091390860927, 9097.408668436563, 9100.408473449237, 8906.332025098143, 8961.103889611019, 8973.416727912665, 8990.280777537813, 8994.685186018458, 8888.511131887744, 8997.190252877272, 9012.188902998696, 9013.819723605557, 9015.27877769777, 42029.36955945663, 42580.57419425828, 42626.0, 42725.78637106826, 42731.78634106841, 3489.685928266468, 3687.9262414751825, 3712.201876596545, 3990.7206495545324, 4185.455890734215, 32436.6756332436, 32587.348253035045, 32643.51034734457, 32661.83669081663, 32702.836485817657, 3931.0, 4113.91772164558, 4134.04881632571, 4170.207660544487, 4199.223143718422, 293280.0, 295157.99999999785, 295180.0, 295969.0, 296765.0, 58777.0, 58965.0, 58983.41016589865, 59437.40562594319, 59511.404885950586, 62142.37857621456, 62338.68830655908, 62376.0, 62620.0, 62663.373366265754, 15513.84486155124, 15738.134402607737, 15750.291236894367, 15770.369185232692, 15772.68454630901, 11592.0, 11601.303921764722, 11627.302361858316, 11674.241174323812, 11680.182387232811, 18623.699951500876, 19514.877619581082, 19523.183968271933, 19567.510812229808, 19630.21479140847, 6092.482139018144, 7007.614581197981, 7190.721520695178, 7257.129144502694, 7349.154847192534, 1080.1790639114329, 1106.6126855600637, 1119.832025196227, 1146.1461211397561, 1207.3118322556059, 29992.70007299943, 30710.0, 31619.84190079035, 32563.348733025206, 33083.834580827424, 1094.7263184203948, 1104.4919337104861, 1105.0441368216434, 1188.0495603517152, 1209.9896586350496, 16429.58926026859, 16740.58148546296, 16753.413630522875, 16766.245518951677, 16871.32514699423, 399015.0, 404274.0, 405313.0, 406098.0, 406382.0, 55070.0, 55402.72298638481, 55732.72133639306, 55778.0, 55805.37265077838, 1213.1144264686652, 1357.2060344698461, 1360.435419300979, 1361.2989310505097, 1383.1286289637665, 30285.242868928453, 32022.67977320197, 32309.838450807594, 32357.191070223435, 32837.34325313433, 46563.740538162005, 47566.52433475621, 47588.2861757067, 47596.52403475921, 47624.809379764396, 294563.0, 306374.0, 306610.0, 306627.0, 306875.0, 41120.0, 41753.79123104365, 48660.5133948656, 50134.0, 50446.0, 48899.0, 48931.75534122449, 50005.0, 50257.24614130718, 50688.0, 38560.61439385683, 38783.41824872573, 39200.60799391969, 39458.80270598744, 40293.59706402898, 41484.37773433341, 41502.792486037375, 42032.36951445792, 42166.36750448684, 43550.56449435592, 41455.0, 41792.58207417887, 42378.0, 42838.78580607077, 42853.1429371417, 36805.26389472249, 37819.243615126994, 37905.24189516249, 38316.61683383131, 38576.22847543089, 29486.557701634923, 29600.851995740744, 29620.851895740383, 29624.85187574048, 29929.251768705955], "unit": "score", "name": "ext.html", "value": 19861.35981509159}, {"lowerIsBetter": false, "replicates": [344.552082293019, 351.46226273801085, 351.89091381671676, 355.36389862146757, 356.5311615225979, 17569.1215439228, 17702.555492259566, 19680.704789428153, 19741.0, 19753.407397778054, 17981.59270103631, 18599.81400186001, 19018.524536886584, 19069.427917162506, 19078.904605476953, 5402.216678581603, 5555.638883472581, 5573.554115670737, 5578.41426650202, 5582.413846546095, 3972.5828787977134, 5449.4005659377435, 5766.711664416784, 5980.671063091529, 6002.549808764338, 5958.0, 5958.433948774881, 5965.821025369224, 5979.2824861016525, 5992.400759924017, 5833.504152147073, 5864.472197502224, 5974.462298393122, 5979.760809567612, 6060.151578778975, 3530.346885826105, 5078.746062696888, 5260.158374660036, 5273.288106105665, 5277.340332458442, 21960.670589941165, 22403.32790016302, 22452.550948981094, 22956.77043229563, 22958.311250662508, 2421.116292553223, 2451.718052423976, 2500.624906264057, 2711.064682684471, 2903.2016195546184, 14013.5095271665, 14126.50557230492, 14137.434502619883, 14234.715305693828, 14584.416623335053, 1923.1057558235489, 2003.4590660521724, 2008.5480766827493, 2050.5693804301113, 2102.6530622447276, 67634.32365676378, 69086.65456672735, 69149.65425172843, 69574.65212673905, 70039.0, 10196.898031019744, 10350.637727679496, 10470.790584188273, 10563.260571760056, 10655.73360665974, 13509.392077356542, 13578.524751633842, 13579.117357371739, 13580.320983950764, 13591.796123058162, 7429.2570742926355, 7526.548407095592, 7557.261829779181, 7642.0, 7656.425768067305, 7116.146062472537, 7182.0, 7192.748253811092, 7242.493025488166, 7375.336219740249, 6495.1556297681, 6521.6413097279155, 6556.868862622816, 6565.474762019123, 6569.605823650596, 1642.2199455258656, 1690.653416049707, 1720.698877696398, 1723.612187257857, 1740.782402199725, 964.8166848298941, 1049.1606714628267, 1108.1135091926587, 1127.402476687357, 1164.6098556983504, 18536.536586585175, 19248.326308579133, 19262.614747705247, 19337.463775357024, 19657.705134422995, 1029.5572903651503, 1063.5214153630898, 1076.5101878645198, 1077.197487871525, 1117.4859564600213, 10918.50866711, 11307.94346028281, 11330.94334528322, 11349.60276390339, 11362.147838912115, 462171.0, 464013.0, 466026.0, 495551.0, 537891.0, 72446.0, 73605.6319718398, 74101.0, 74314.0, 74895.62552187205, 965.9806803863743, 1057.0, 1069.9518521666544, 1078.0890147825075, 1081.9296745711504, 16136.515904522883, 16257.59356016109, 16360.672786543964, 16729.0, 16730.749038764672, 32626.347473049933, 33641.831790840886, 34038.0, 34096.31807363888, 34223.0, 38764.80617596894, 39466.802665986484, 40852.79573602113, 41128.38307425331, 41368.0, 7977.880331794911, 8038.075621303391, 8068.798280043045, 8082.353411727166, 8088.797780055545, 13219.339033048502, 13258.469661213443, 13378.197308161542, 13508.459661613819, 13648.454061837416, 6232.314445411092, 7456.850862982818, 10145.340552864336, 10329.483525823529, 11746.58886938953, 11183.776324473627, 11217.0, 11556.364399958084, 11595.942020289845, 11660.30038197711, 11886.702832429259, 11974.580889669169, 12048.939755301168, 12122.515099396278, 12291.508339666314, 7288.161861385796, 7471.775846724607, 7554.924450755642, 7573.318401343906, 8302.584870756558, 10731.517081731185, 11924.582639607572, 11956.641300760992, 12003.63989080329, 12204.0], "unit": "score", "name": "jquery.html", "value": 8930.135665420896}, {"lowerIsBetter": false, "replicates": [1323.675699453634, 1498.0412535976977, 1507.0, 1704.403458789424, 1855.0446520042171, 7645.235476452359, 7798.454108212421, 7816.491928024674, 7823.3350165236025, 7828.412869034817, 7569.167391586935, 7681.270279323469, 7720.922790772091, 7721.652525636346, 7748.612569371523, 1946.698261769428, 1997.0414201183441, 2198.604251234777, 2225.7440394354653, 2258.9209377671787, 2225.1655629139073, 2232.5423288225875, 2233.62028455163, 2235.8099561537288, 2238.2278114050628, 2168.8807115608633, 2200.713907192063, 2206.6138425775425, 2208.8785116818567, 2212.0045979309375, 2166.620841352757, 2206.481476852938, 2209.9889500552554, 2215.46828761097, 2222.866628002325, 2171.630822760119, 2180.7710190430093, 2182.454386403399, 2190.5509370578993, 2190.6385446401323, 7862.921370786276, 7928.722494712715, 7930.167332430069, 7947.920520794776, 7952.085510166347, 4717.787699553528, 4818.325434439182, 4849.369581954358, 4851.442084160331, 4852.1508735971065, 3162.620485541727, 3265.363254165439, 3299.5215693724276, 3310.0, 3330.1841048943165, 1043.12377602814, 1047.879493858201, 1075.172117469544, 1082.5020490574266, 1116.625930313346, 10563.68308950725, 10678.466076696212, 10691.144708423308, 10692.572297108185, 10711.089557387631, 4179.1432756284885, 4201.621854033152, 4316.611504964569, 4320.675949303814, 4329.415528903621, 9360.063993600585, 9380.765480863032, 9442.763930901645, 9717.416954982724, 9725.173360264314, 4976.601871850244, 4993.525615066563, 4996.675216110941, 4997.225430058346, 5001.4998500149695, 3851.672607828366, 4394.1870753910625, 4490.50604433512, 4497.168023915586, 4512.684112112186, 3730.0301921500063, 3782.791946442972, 3812.7331086823656, 3815.771053736785, 3849.615038496128, 1138.7779383020397, 1140.3841925360377, 1140.7775483780583, 1144.5707859552667, 1149.8620165580185, 1074.6937122920087, 1083.0956151613334, 1235.7034311765112, 1415.0519152168072, 1438.0293302021093, 7354.96322518384, 7472.364848987897, 7494.812629684193, 7685.116211635622, 7693.576853273012, 435.8823117758251, 436.45225242321317, 438.2309047621404, 440.0956035347392, 458.3926297655553, 6052.54605904559, 6110.144579758838, 6112.449879510777, 6119.84700382494, 6151.907721384183, 9102.089791020977, 9601.855972160423, 9673.661421850342, 9690.0, 9694.563744631509, 9452.338336316392, 9509.0, 9610.66362677317, 9640.71077867665, 9647.855282170773, 7394.371478424394, 7540.962295188599, 7615.5430674159725, 7675.270849269311, 7705.4220933430215, 7274.963625182052, 7410.147832999274, 7429.294217049372, 7440.0, 7443.516171448839, 8487.108853570286, 8642.0, 8809.647614095364, 8831.161039701217, 8857.734267971971, 8385.413021088709, 8918.598663060047, 8922.420042697204, 8939.374243802871, 8951.149640784115, 6296.2759282681245, 6827.453803695593, 7015.052967849275, 7054.788356349318, 7131.572105673677, 7528.736494222676, 7539.283768042027, 7551.924480755122, 7572.280633339824, 7582.54504729718, 6665.400113989765, 6770.52606317553, 6783.626900520519, 6803.455723542006, 6964.338387853146, 6655.534112612071, 6705.731770729116, 6713.429358504582, 6716.29478904708, 6792.626405547742, 7026.543274687129, 7077.858442831218, 7080.362767350963, 7144.67848946809, 7289.599072051088, 6506.707198176188, 6510.3489651034515, 6540.640264785482, 6553.770618028346, 6566.212054553484, 6653.234877989094, 6702.564333318319, 6703.0, 6713.295104014008, 6752.696128674123], "unit": "score", "name": "mootools.html", "value": 4434.822375431496}, {"lowerIsBetter": false, "replicates": [302.72603294018904, 305.3374178033667, 308.1602632825551, 308.70364450127863, 309.9178717639824, 5889.322727886294, 5928.170056192132, 5931.228940237774, 5993.88012239755, 5997.250343707036, 5882.941170588293, 5934.961381758197, 5974.163617093611, 5977.372375900533, 5984.910226346608, 4276.465441819772, 4390.495093064291, 4455.710378825383, 4509.616682581968, 4556.4760052593965, 4485.618722408599, 4497.123061003105, 4503.864884053483, 4506.8422605208825, 4518.525554816746, 4460.33095035744, 4462.821487140511, 4464.776761161929, 4470.128324976631, 4471.262241730111, 4211.620954114129, 4323.567643235683, 4411.558844115595, 4412.624926881219, 4419.049904270565, 3797.2025874566375, 3804.6766024887916, 3805.315043292206, 3817.770933743984, 3818.5417749870194, 5642.322921249476, 5644.689542075184, 5647.689377084259, 5650.265465489501, 5650.434956504317, 5097.745112744348, 5100.336956195708, 5103.157978933472, 5104.055749686283, 5104.285400043959, 6119.479844213247, 6138.938610613882, 6146.17026701394, 6157.661328626924, 6176.042713379434, 4093.0, 4203.600657937491, 4218.346156345771, 4220.85227017056, 4225.830966761326, 6465.77369792055, 6493.837654058639, 6515.02274658805, 6516.902246466307, 6522.249941256769, 4285.142971405669, 4289.1636130954785, 4290.613844753987, 4293.742375457483, 4313.870583882489, 4326.480822301344, 4368.126374725068, 4368.191884501377, 4371.0, 4372.147431250875, 5076.416212135578, 5085.9745701271995, 5092.0579692756955, 5092.337996060563, 5097.949020509747, 6236.937630623726, 6251.28110267316, 6253.093301471261, 6255.374462553708, 6258.186435763413, 1483.0, 1515.053091817614, 1517.2034681792147, 1517.5750789778879, 1518.3471107423914, 949.0414681172066, 973.522973742875, 984.4093543873619, 1004.864343313658, 1022.4989755019986, 5938.465538101592, 5952.9107063394085, 5985.581009329392, 5999.610025348338, 6006.969965150146, 6347.841303967345, 6366.649834259068, 6366.872662546723, 6372.299047104815, 6378.234611846516, 5965.910511342333, 5972.671503067286, 5982.252218472691, 5985.6408615483215, 5987.491063259585, 3397.4394224952607, 3429.416999110157, 3433.639467855889, 3435.0, 3435.811030393302, 6479.6760161991715, 6635.734570617218, 6639.136912201383, 6657.1012913257055, 6659.6670166491485, 6455.61266324022, 6473.77341793035, 6491.221053473613, 6510.08858759774, 6518.217813862367, 6640.734370625121, 6643.169603799525, 6645.1361323027695, 6649.135612370457, 6652.833679158157, 6357.237131544244, 6364.809055728336, 6365.8726825464155, 6369.172007638977, 6372.07604897278, 6188.1027251049245, 6249.500039996698, 6281.0, 6289.308176100534, 6364.045393190873, 6752.527323087534, 6768.661566921536, 6769.289224631343, 6786.151731033621, 6793.048973143665, 4386.035072284092, 4419.13826803783, 4423.778811059498, 4429.180601588717, 4430.534793846599, 6441.581297215666, 6459.806205813833, 6466.094746735367, 6466.935330646822, 6475.320091390525, 6280.057991301342, 6295.213098362705, 6311.305756366704, 6314.084457753508, 6319.304876463493, 6053.424924632153, 6205.844853878689, 6206.10011548332, 6212.0371342441995, 6218.440340369389, 6082.60463069899, 6094.7257373417415, 6115.877682446415, 6118.552578968448, 6174.228221472316, 6318.05229215603, 6318.462930650946, 6319.083732858801, 6322.525810564134, 6325.0, 5878.559108066997, 5997.730102145327, 6114.816555503342, 6161.661108638888, 6176.598521096114], "unit": "score", "name": "prototype.html", "value": 4652.20178031221}, {"lowerIsBetter": false, "replicates": [754.4718696912163, 756.2210922749566, 814.1532805881882, 835.3985130705889, 895.5611750242381, 14554.12675239485, 14699.0, 14723.337449814757, 14734.18961957092, 14876.925615371922, 13291.800622990662, 14034.087784294014, 14203.71592568148, 14228.07517511361, 14248.358823852926, 696.3245651717825, 838.4298676899706, 854.2098558833086, 871.1071152069117, 875.544716747291, 860.0625318402939, 865.0, 865.0138841720412, 865.7359505350897, 866.536403024382, 911.5715613661602, 911.8677791720197, 914.0356923445762, 914.1681070226095, 915.1489115122934, 722.3895808042196, 885.9379843410964, 899.6446403670514, 899.9640014399416, 901.1394118616705, 659.3307792590524, 660.1055569703032, 660.3990368764402, 661.3518751623388, 661.4146480364864, 14699.338529766079, 14744.115353078849, 14762.70474590502, 14777.7783333249, 14780.187089710169, 13594.524191653343, 13793.931030344884, 13891.235982020984, 13982.510612128628, 14872.0, 11159.553617855276, 11387.08903287735, 11493.885061149365, 11536.538538458452, 11609.593664221711, 4516.254817955033, 4600.4479462464715, 4640.883977900579, 4738.857834264978, 4756.215224487955, 49328.50671493275, 49469.99999999964, 49937.0, 50353.49646503525, 50384.496155038716, 11159.330440173615, 11168.609098681507, 11355.26190797612, 11428.599998999995, 11481.71295717597, 18281.81718182828, 18300.633987320445, 18312.267509299745, 18318.725219121723, 18320.725189122175, 8201.79495512617, 8274.379421543408, 8405.369597280229, 8618.827623447622, 8635.525046122524, 4682.0, 4845.127876982177, 4872.512748725099, 4896.045271172158, 5032.094223039888, 3287.474004159323, 3321.0534997525588, 3322.2358857462436, 3324.900252992414, 3333.0500807269814, 514.269736973491, 599.6701814002281, 601.4526780629606, 657.4970147836908, 665.3346653346654, 666.7666316789085, 752.2702978111223, 783.2989474420361, 791.4459878085363, 804.4489524675616, 9047.728568142966, 9331.813363732688, 9565.426074435556, 9638.373505722106, 9742.0, 775.309974123031, 789.1989630525022, 792.7502836606451, 805.452292441134, 819.1562690428868, 4467.539679784962, 4544.409226800495, 4605.953940460619, 4615.5845973862515, 4649.86050418488, 64169.35830641634, 64757.0, 65046.34953650403, 65066.0, 65587.0, 58528.0, 58574.0, 58877.0, 59027.40972590305, 63173.684131579044, 48561.514384856404, 48689.513104869206, 49353.0, 49424.75287623539, 50255.497445025816, 10053.597856085675, 10067.546960386946, 10094.0, 10098.848517272394, 10115.949420252851, 40134.0, 40715.79642101771, 40774.59225407708, 41428.58571414247, 41854.16291674088, 49439.752801235765, 52297.0, 52489.737551312, 52517.7374113127, 53385.0, 12418.192817466836, 12840.743185136433, 12988.0, 13202.943764499008, 13220.537281195113, 13869.583912482642, 14082.577522674335, 14255.857441425453, 14623.195724234844, 15014.6997060056, 13362.532311369445, 13410.396532156272, 13496.797548036591, 13872.4451021958, 13921.721565568429, 13033.15284506504, 13076.0, 13127.146735462164, 13351.532696355582, 13978.65053373633, 13352.599422017354, 13482.595522134352, 13977.510787122403, 14027.438902443788, 14317.498887538886, 11126.221164518405, 11214.439278035903, 11327.15046371509, 11420.200585958903, 11546.0, 11241.381724005258, 11334.206605537533, 11413.885861141282, 11462.254953428, 11684.357360345262], "unit": "score", "name": "yui.html", "value": 7071.451783521934}], "name": "dromaeo_css", "value": 7135.7475648902455}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 110.0, 111.0, 100.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [146.0, 124.0, 148.0, 166.0, 126.0, 149.0, 156.0, 128.0, 172.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 163.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 96.0, 96.0, 74.0, 75.0, 76.0, 108.0, 99.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 147.0, 92.0, 92.0, 92.0, 139.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 62.0, 56.0, 55.0, 55.0, 56.0, 66.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.6}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 77.0, 77.0, 77.0, 78.0, 78.0, 78.0, 78.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.6}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 111.0, 110.0, 106.0, 120.0, 107.0, 118.0, 113.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.6}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 140.0, 142.0, 140.0, 128.0, 142.0, 142.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 67.0, 63.0, 61.0, 63.0, 63.0, 61.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.3}], "name": "kraken", "value": 1472.3}]} 04:25:29 INFO - Return code: 0 04:25:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:25:29 ERROR - # TBPL SUCCESS # 04:25:29 INFO - Running post-action listener: _resource_record_post_action 04:25:29 INFO - Running post-run listener: _resource_record_post_run 04:25:30 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 538738688; Read time: 0; Write time: 428900 04:25:30 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242343936; Read time: 0; Write time: 237932 04:25:30 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 296394752; Read time: 0; Write time: 190968 04:25:30 INFO - Running post-run listener: _upload_blobber_files 04:25:30 INFO - Blob upload gear active. 04:25:30 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:25:30 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 04:25:30 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:25:30 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:25:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:32 INFO - (blobuploader) - INFO - Done attempting. 04:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:32 INFO - (blobuploader) - INFO - Done attempting. 04:25:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:32 INFO - Return code: 0 04:25:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:25:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fccfcdd6772abfb6978fa4fde3b7bbdcf7693b6562b0f15c72e58d621febce2ec772f2c3558604fcab2ff5f79772718c43cdc7516c8b1a399998f92e59874ab8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4520f62cc417cca43b37073c43e52d7ede3bc777545f4ec9ec023e218987c3a3b4923c4f33a829d13dd13cec9bed145fa413967787f7a64788d75afb420765c3"} 04:25:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:25:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:25:32 INFO - Contents: 04:25:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fccfcdd6772abfb6978fa4fde3b7bbdcf7693b6562b0f15c72e58d621febce2ec772f2c3558604fcab2ff5f79772718c43cdc7516c8b1a399998f92e59874ab8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4520f62cc417cca43b37073c43e52d7ede3bc777545f4ec9ec023e218987c3a3b4923c4f33a829d13dd13cec9bed145fa413967787f7a64788d75afb420765c3"} 04:25:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:32 INFO - Copying logs to upload dir... 04:25:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:25:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.121742 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-12 04:25:32.501385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 04:25:32.505372) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fccfcdd6772abfb6978fa4fde3b7bbdcf7693b6562b0f15c72e58d621febce2ec772f2c3558604fcab2ff5f79772718c43cdc7516c8b1a399998f92e59874ab8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4520f62cc417cca43b37073c43e52d7ede3bc777545f4ec9ec023e218987c3a3b4923c4f33a829d13dd13cec9bed145fa413967787f7a64788d75afb420765c3"} build_url:https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/VdotV-I_REKeFQog4_I7wQ/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/Mozilla-Inbound/sha512/fccfcdd6772abfb6978fa4fde3b7bbdcf7693b6562b0f15c72e58d621febce2ec772f2c3558604fcab2ff5f79772718c43cdc7516c8b1a399998f92e59874ab8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4520f62cc417cca43b37073c43e52d7ede3bc777545f4ec9ec023e218987c3a3b4923c4f33a829d13dd13cec9bed145fa413967787f7a64788d75afb420765c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-12 04:25:32.530653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:25:32.530980) ========= 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-1457778990.751368-27690497 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-12 04:25:32.612936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 04:25:32.613268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-12 04:25:32.613599) ========= ========= Total master_lag: 0.35 =========