builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1459919005.85 results: success (0) buildid: 20160405193250 builduid: c0a619eeda064753a504042e0e31f468 revision: 496db28e275d83a8a8d57033384d18199ccbcbd9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.847661) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.848124) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.848415) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006240 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.875380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.875685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.892158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:25.892443) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.040103) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.040415) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.040788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.041076) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 22:03:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.6M=0s 2016-04-05 22:03:27 (95.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.227359 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.320847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.321124) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020363 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:26.500386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 22:03:26.500720) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 496db28e275d83a8a8d57033384d18199ccbcbd9 --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 496db28e275d83a8a8d57033384d18199ccbcbd9 --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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 22:03:27,334 truncating revision to first 12 chars 2016-04-05 22:03:27,334 Setting DEBUG logging. 2016-04-05 22:03:27,334 attempt 1/10 2016-04-05 22:03:27,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/496db28e275d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 22:03:28,419 unpacking tar archive at: mozilla-inbound-496db28e275d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.534292 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 22:03:28.063105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:28.063437) ========= echo 496db28e275d83a8a8d57033384d18199ccbcbd9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'496db28e275d83a8a8d57033384d18199ccbcbd9'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 496db28e275d83a8a8d57033384d18199ccbcbd9 program finished with exit code 0 elapsedTime=0.004848 script_repo_revision: '496db28e275d83a8a8d57033384d18199ccbcbd9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:28.120745) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:28.121049) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 22:03:28.142348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-05 22:03:28.142667) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:03:29 INFO - MultiFileLogger online at 20160405 22:03:29 in /builds/slave/test-pgo 22:03:29 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 22:03:29 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:03:29 INFO - {'append_to_log': False, 22:03:29 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:03:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:03:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:03:29 INFO - 'branch': 'Mozilla-Inbound', 22:03:29 INFO - 'buildbot_json_path': 'buildprops.json', 22:03:29 INFO - 'config_files': ('talos/linux_config.py',), 22:03:29 INFO - 'default_actions': ('clobber', 22:03:29 INFO - 'read-buildbot-config', 22:03:29 INFO - 'download-and-extract', 22:03:29 INFO - 'populate-webroot', 22:03:29 INFO - 'create-virtualenv', 22:03:29 INFO - 'install', 22:03:29 INFO - 'run-tests'), 22:03:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:03:29 INFO - 'download_minidump_stackwalk': True, 22:03:29 INFO - 'download_symbols': 'ondemand', 22:03:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:03:29 INFO - 'tooltool.py': '/tools/tooltool.py', 22:03:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:03:29 INFO - '/tools/misc-python/virtualenv.py')}, 22:03:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:03:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:03:29 INFO - 'installer_path': 'installer.exe', 22:03:29 INFO - 'log_level': 'info', 22:03:29 INFO - 'log_name': 'talos', 22:03:29 INFO - 'log_to_console': True, 22:03:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:03:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:03:29 INFO - 'opt_config_files': (), 22:03:29 INFO - 'pip_index': False, 22:03:29 INFO - 'sps_profile': False, 22:03:29 INFO - 'sps_profile_interval': 0, 22:03:29 INFO - 'suite': 'dromaeojs', 22:03:29 INFO - 'system_bits': '32', 22:03:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:03:29 INFO - 'title': 'talos-linux64-ix-051', 22:03:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:03:29 INFO - 'use_talos_json': True, 22:03:29 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:03:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:03:29 INFO - 'work_dir': 'build'} 22:03:29 INFO - ##### 22:03:29 INFO - ##### Running clobber step. 22:03:29 INFO - ##### 22:03:29 INFO - Running pre-action listener: _resource_record_pre_action 22:03:29 INFO - Running main action method: clobber 22:03:29 INFO - rmtree: /builds/slave/test-pgo/build 22:03:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:03:29 INFO - Running post-action listener: _resource_record_post_action 22:03:29 INFO - ##### 22:03:29 INFO - ##### Running read-buildbot-config step. 22:03:29 INFO - ##### 22:03:29 INFO - Running pre-action listener: _resource_record_pre_action 22:03:29 INFO - Running main action method: read_buildbot_config 22:03:29 INFO - Using buildbot properties: 22:03:29 INFO - { 22:03:29 INFO - "project": "", 22:03:29 INFO - "product": "firefox", 22:03:29 INFO - "script_repo_revision": "production", 22:03:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:03:29 INFO - "repository": "", 22:03:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:03:29 INFO - "buildid": "20160405193250", 22:03:29 INFO - "pgo_build": "True", 22:03:29 INFO - "basedir": "/builds/slave/test-pgo", 22:03:29 INFO - "buildnumber": 1677, 22:03:29 INFO - "slavename": "talos-linux64-ix-051", 22:03:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:03:29 INFO - "platform": "ubuntu64_hw", 22:03:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:03:29 INFO - "branch": "mozilla-inbound", 22:03:29 INFO - "repo_path": "integration/mozilla-inbound", 22:03:29 INFO - "revision": "496db28e275d83a8a8d57033384d18199ccbcbd9", 22:03:29 INFO - "stage_platform": "linux64-pgo", 22:03:29 INFO - "builduid": "c0a619eeda064753a504042e0e31f468", 22:03:29 INFO - "slavebuilddir": "test" 22:03:29 INFO - } 22:03:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:03:29 INFO - Running post-action listener: _resource_record_post_action 22:03:29 INFO - ##### 22:03:29 INFO - ##### Running download-and-extract step. 22:03:29 INFO - ##### 22:03:29 INFO - Running pre-action listener: _resource_record_pre_action 22:03:29 INFO - Running main action method: download_and_extract 22:03:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:03:29 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')]} 22:03:29 INFO - https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:03:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:03:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:03:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:30 INFO - Downloaded 1361 bytes. 22:03:30 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:03:30 INFO - Using the following test package requirements: 22:03:30 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:03:30 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:03:30 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:03:30 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'jsshell-linux-x86_64.zip'], 22:03:30 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:03:30 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:03:30 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:03:30 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:03:30 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:03:30 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:03:30 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:03:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:30 INFO - https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:03:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:03:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:03:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:34 INFO - Downloaded 23700478 bytes. 22:03:34 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'] 22:03:34 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 22:03:35 INFO - Return code: 0 22:03:35 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 22:03: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')]} 22:03:35 INFO - https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:39 INFO - Downloaded 23700478 bytes. 22:03:39 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'] 22:03:39 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 22:03:41 INFO - Return code: 0 22:03:41 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')]} 22:03:41 INFO - https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:43 INFO - Downloaded 10847617 bytes. 22:03:43 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'] 22:03:43 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 22:03:43 INFO - Return code: 0 22:03:43 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')]} 22:03:43 INFO - https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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 22:03:46 INFO - Downloaded 57818773 bytes. 22:03:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:03:46 INFO - mkdir: /builds/slave/test-pgo/properties 22:03:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:03:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:03:46 INFO - Contents: 22:03:46 INFO - build_url:https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:03:47 INFO - Running post-action listener: _resource_record_post_action 22:03:47 INFO - Running post-action listener: set_extra_try_arguments 22:03:47 INFO - ##### 22:03:47 INFO - ##### Running populate-webroot step. 22:03:47 INFO - ##### 22:03:47 INFO - Running pre-action listener: _resource_record_pre_action 22:03:47 INFO - Running main action method: populate_webroot 22:03:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:03:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:03:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:03:47 INFO - '--tppagecycles', 22:03:47 INFO - '7'], 22:03:47 INFO - 'tests': ['tsvgm']}}, 22:03:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:03:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:03:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:03:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:03:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:03:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:03:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['damp', 'tps']}, 22:03:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'tests': ['damp', 'tps']}, 22:03:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['dromaeo_dom']}, 22:03:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:03:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'other-e10s': {'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['a11yr', 22:03:47 INFO - 'ts_paint', 22:03:47 INFO - 'tpaint', 22:03:47 INFO - 'sessionrestore', 22:03:47 INFO - 'sessionrestore_no_auto_restore', 22:03:47 INFO - 'tabpaint']}, 22:03:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['tsvgx', 22:03:47 INFO - 'tsvgr_opacity', 22:03:47 INFO - 'tart', 22:03:47 INFO - 'tscrollx', 22:03:47 INFO - 'cart']}, 22:03:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:03:47 INFO - 'tsvgr_opacity', 22:03:47 INFO - 'tart', 22:03:47 INFO - 'tscrollx', 22:03:47 INFO - 'cart']}, 22:03:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'talos_options': ['--disable-e10s'], 22:03:47 INFO - 'tests': ['tp5o']}, 22:03:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'tests': ['tp5o']}, 22:03:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'talos_options': ['--disable-e10s', 22:03:47 INFO - '--xperf_path', 22:03:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:03:47 INFO - 'tests': ['tp5n']}, 22:03:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:03:47 INFO - 'talos_options': ['--xperf_path', 22:03:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:03:47 INFO - 'tests': ['tp5n']}}, 22:03:47 INFO - 'talos.zip': {'path': '', 22:03:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:03:47 INFO - Running post-action listener: _resource_record_post_action 22:03:47 INFO - ##### 22:03:47 INFO - ##### Running create-virtualenv step. 22:03:47 INFO - ##### 22:03:47 INFO - Running pre-action listener: _resource_record_pre_action 22:03:47 INFO - Running main action method: create_virtualenv 22:03:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:03:47 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 22:03:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:03:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:03:47 INFO - Using real prefix '/usr' 22:03:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:03:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:03:49 INFO - Installing pip.................done. 22:03:49 INFO - Return code: 0 22:03:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:03:49 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')]} 22:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:49 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')]} 22:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:49 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:03:49 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 22:03:49 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 22:03:49 INFO - Using env: {'DISPLAY': ':0', 22:03:49 INFO - 'HOME': '/home/cltbld', 22:03:49 INFO - 'LANG': 'en_US.UTF-8', 22:03:49 INFO - 'LANGUAGE': 'en_US:en', 22:03:49 INFO - 'LOGNAME': 'cltbld', 22:03:49 INFO - 'MAIL': '/var/mail/cltbld', 22:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:49 INFO - 'MOZ_NO_REMOTE': '1', 22:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:49 INFO - 'NO_EM_RESTART': '1', 22:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:03:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:03:49 INFO - 'SHELL': '/bin/bash', 22:03:49 INFO - 'SHLVL': '1', 22:03:49 INFO - 'TERM': 'linux', 22:03:49 INFO - 'TMOUT': '86400', 22:03:49 INFO - 'USER': 'cltbld', 22:03:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:49 INFO - '_': '/tools/buildbot/bin/python'} 22:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:50 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 22:03:50 INFO - Cleaning up... 22:03:50 INFO - Return code: 0 22:03:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:03:50 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')]} 22:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:50 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')]} 22:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:50 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:03:50 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 22:03:50 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 22:03:50 INFO - Using env: {'DISPLAY': ':0', 22:03:50 INFO - 'HOME': '/home/cltbld', 22:03:50 INFO - 'LANG': 'en_US.UTF-8', 22:03:50 INFO - 'LANGUAGE': 'en_US:en', 22:03:50 INFO - 'LOGNAME': 'cltbld', 22:03:50 INFO - 'MAIL': '/var/mail/cltbld', 22:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:50 INFO - 'MOZ_NO_REMOTE': '1', 22:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:50 INFO - 'NO_EM_RESTART': '1', 22:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:03:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:03:50 INFO - 'SHELL': '/bin/bash', 22:03:50 INFO - 'SHLVL': '1', 22:03:50 INFO - 'TERM': 'linux', 22:03:50 INFO - 'TMOUT': '86400', 22:03:50 INFO - 'USER': 'cltbld', 22:03:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:50 INFO - '_': '/tools/buildbot/bin/python'} 22:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:50 INFO - Downloading/unpacking psutil>=0.7.1 22:03:50 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 22:03:50 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 22:03:50 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 22:03:50 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 22:03:50 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 22:03:50 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 22:03:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:03:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:03:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:03:52 INFO - Installing collected packages: psutil 22:03:52 INFO - Running setup.py install for psutil 22:03:53 INFO - building 'psutil._psutil_linux' extension 22:03:53 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 22:03:53 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 22:03:53 INFO - building 'psutil._psutil_posix' extension 22:03:53 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 22:03:53 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 22:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:03:53 INFO - Successfully installed psutil 22:03:53 INFO - Cleaning up... 22:03:53 INFO - Return code: 0 22:03:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:53 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:03:53 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 22:03:53 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 22:03:53 INFO - Using env: {'DISPLAY': ':0', 22:03:53 INFO - 'HOME': '/home/cltbld', 22:03:53 INFO - 'LANG': 'en_US.UTF-8', 22:03:53 INFO - 'LANGUAGE': 'en_US:en', 22:03:53 INFO - 'LOGNAME': 'cltbld', 22:03:53 INFO - 'MAIL': '/var/mail/cltbld', 22:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:53 INFO - 'MOZ_NO_REMOTE': '1', 22:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:53 INFO - 'NO_EM_RESTART': '1', 22:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:03:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:03:53 INFO - 'SHELL': '/bin/bash', 22:03:53 INFO - 'SHLVL': '1', 22:03:53 INFO - 'TERM': 'linux', 22:03:53 INFO - 'TMOUT': '86400', 22:03:53 INFO - 'USER': 'cltbld', 22:03:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:53 INFO - '_': '/tools/buildbot/bin/python'} 22:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:03:53 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 22:03:53 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 22:03:53 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 22:03:53 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 22:03:53 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 22:03:53 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 22:03:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:03:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:03:56 INFO - Installing collected packages: mozsystemmonitor 22:03:56 INFO - Running setup.py install for mozsystemmonitor 22:03:56 INFO - Successfully installed mozsystemmonitor 22:03:56 INFO - Cleaning up... 22:03:56 INFO - Return code: 0 22:03:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:03:56 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:03:56 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 22:03:56 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 22:03:56 INFO - Using env: {'DISPLAY': ':0', 22:03:56 INFO - 'HOME': '/home/cltbld', 22:03:56 INFO - 'LANG': 'en_US.UTF-8', 22:03:56 INFO - 'LANGUAGE': 'en_US:en', 22:03:56 INFO - 'LOGNAME': 'cltbld', 22:03:56 INFO - 'MAIL': '/var/mail/cltbld', 22:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:56 INFO - 'MOZ_NO_REMOTE': '1', 22:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:56 INFO - 'NO_EM_RESTART': '1', 22:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:03:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:03:56 INFO - 'SHELL': '/bin/bash', 22:03:56 INFO - 'SHLVL': '1', 22:03:56 INFO - 'TERM': 'linux', 22:03:56 INFO - 'TMOUT': '86400', 22:03:56 INFO - 'USER': 'cltbld', 22:03:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:56 INFO - '_': '/tools/buildbot/bin/python'} 22:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:03:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:03:56 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 22:03:56 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 22:03:56 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 22:03:56 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 22:03:56 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 22:03:56 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 22:03:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:03:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:03:59 INFO - Downloading docopt-0.6.1.tar.gz 22:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:00 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:00 INFO - Running setup.py install for blobuploader 22:04:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:04:00 INFO - Running setup.py install for requests 22:04:00 INFO - Running setup.py install for docopt 22:04:00 INFO - Successfully installed blobuploader requests docopt 22:04:00 INFO - Cleaning up... 22:04:00 INFO - Return code: 0 22:04:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:00 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:04:00 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 22:04:00 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 22:04:00 INFO - Using env: {'DISPLAY': ':0', 22:04:00 INFO - 'HOME': '/home/cltbld', 22:04:00 INFO - 'LANG': 'en_US.UTF-8', 22:04:00 INFO - 'LANGUAGE': 'en_US:en', 22:04:00 INFO - 'LOGNAME': 'cltbld', 22:04:00 INFO - 'MAIL': '/var/mail/cltbld', 22:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:00 INFO - 'MOZ_NO_REMOTE': '1', 22:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:00 INFO - 'NO_EM_RESTART': '1', 22:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:00 INFO - 'SHELL': '/bin/bash', 22:04:00 INFO - 'SHLVL': '1', 22:04:00 INFO - 'TERM': 'linux', 22:04:00 INFO - 'TMOUT': '86400', 22:04:00 INFO - 'USER': 'cltbld', 22:04:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:00 INFO - '_': '/tools/buildbot/bin/python'} 22:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:00 INFO - Running setup.py (path:/tmp/pip-dyH9tw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:00 INFO - Running setup.py (path:/tmp/pip-2kX5I1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:01 INFO - Running setup.py (path:/tmp/pip-6cPvht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:01 INFO - Running setup.py (path:/tmp/pip-f0qM3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:01 INFO - Running setup.py (path:/tmp/pip-mRNkup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:01 INFO - Running setup.py (path:/tmp/pip-i7HzpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:01 INFO - Running setup.py (path:/tmp/pip-vpQ68z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:01 INFO - Running setup.py (path:/tmp/pip-TaJDIM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:01 INFO - Running setup.py (path:/tmp/pip-nv3akW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:01 INFO - Running setup.py (path:/tmp/pip-U41EOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:01 INFO - Running setup.py (path:/tmp/pip-1o57rd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:01 INFO - Running setup.py (path:/tmp/pip-m4wPvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:01 INFO - Running setup.py (path:/tmp/pip-77t2Dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:01 INFO - Running setup.py (path:/tmp/pip-EGEfIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:01 INFO - Running setup.py (path:/tmp/pip-XUt5ys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:01 INFO - Running setup.py (path:/tmp/pip-a630Qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:02 INFO - Running setup.py (path:/tmp/pip-ePXVZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:02 INFO - Running setup.py install for manifestparser 22:04:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Running setup.py install for mozcrash 22:04:02 INFO - Running setup.py install for mozdebug 22:04:02 INFO - Running setup.py install for mozdevice 22:04:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Running setup.py install for mozfile 22:04:02 INFO - Running setup.py install for mozhttpd 22:04:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Running setup.py install for mozinfo 22:04:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Running setup.py install for mozInstall 22:04:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:04:02 INFO - Running setup.py install for mozleak 22:04:02 INFO - Running setup.py install for mozlog 22:04:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Running setup.py install for moznetwork 22:04:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Running setup.py install for mozprocess 22:04:03 INFO - Running setup.py install for mozprofile 22:04:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Running setup.py install for mozrunner 22:04:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Running setup.py install for mozscreenshot 22:04:03 INFO - Running setup.py install for moztest 22:04:03 INFO - Running setup.py install for mozversion 22:04:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:04:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:03 INFO - Cleaning up... 22:04:03 INFO - Return code: 0 22:04:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:03 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 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:04:03 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 22:04:03 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 22:04:03 INFO - Using env: {'DISPLAY': ':0', 22:04:03 INFO - 'HOME': '/home/cltbld', 22:04:03 INFO - 'LANG': 'en_US.UTF-8', 22:04:03 INFO - 'LANGUAGE': 'en_US:en', 22:04:03 INFO - 'LOGNAME': 'cltbld', 22:04:03 INFO - 'MAIL': '/var/mail/cltbld', 22:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:03 INFO - 'MOZ_NO_REMOTE': '1', 22:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:03 INFO - 'NO_EM_RESTART': '1', 22:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:03 INFO - 'SHELL': '/bin/bash', 22:04:03 INFO - 'SHLVL': '1', 22:04:03 INFO - 'TERM': 'linux', 22:04:03 INFO - 'TMOUT': '86400', 22:04:03 INFO - 'USER': 'cltbld', 22:04:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:03 INFO - '_': '/tools/buildbot/bin/python'} 22:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:04 INFO - Running setup.py (path:/tmp/pip-7nMbbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:04 INFO - Running setup.py (path:/tmp/pip-zPLC6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:04 INFO - Running setup.py (path:/tmp/pip-OlvNWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:04 INFO - Running setup.py (path:/tmp/pip-TWIVLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:04 INFO - Running setup.py (path:/tmp/pip-ygtyEa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:04 INFO - Running setup.py (path:/tmp/pip-RS3D2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:04 INFO - Running setup.py (path:/tmp/pip-fQWoux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:04 INFO - Running setup.py (path:/tmp/pip-ePCOZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:04 INFO - Running setup.py (path:/tmp/pip-bwX5CR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:04 INFO - Running setup.py (path:/tmp/pip-u8wZbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:04 INFO - Running setup.py (path:/tmp/pip-3kGGgs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:04 INFO - Running setup.py (path:/tmp/pip-O4rV79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:04 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)) 22:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:04 INFO - Running setup.py (path:/tmp/pip-d_jLCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:05 INFO - Running setup.py (path:/tmp/pip-Xd4tvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:05 INFO - Running setup.py (path:/tmp/pip-ggTWLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:05 INFO - Running setup.py (path:/tmp/pip-zRUO1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:04:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:05 INFO - Running setup.py (path:/tmp/pip-tkhE7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:04:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:07 INFO - Downloading blessings-1.6.tar.gz 22:04:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:04:07 INFO - Installing collected packages: blessings 22:04:07 INFO - Running setup.py install for blessings 22:04:07 INFO - Successfully installed blessings 22:04:07 INFO - Cleaning up... 22:04:07 INFO - Return code: 0 22:04:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:04:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:04:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:04:08 INFO - Reading from file tmpfile_stdout 22:04:08 INFO - Current package versions: 22:04:08 INFO - argparse == 1.2.1 22:04:08 INFO - blessings == 1.6 22:04:08 INFO - blobuploader == 1.2.4 22:04:08 INFO - docopt == 0.6.1 22:04:08 INFO - manifestparser == 1.1 22:04:08 INFO - mozInstall == 1.12 22:04:08 INFO - mozcrash == 0.17 22:04:08 INFO - mozdebug == 0.1 22:04:08 INFO - mozdevice == 0.48 22:04:08 INFO - mozfile == 1.2 22:04:08 INFO - mozhttpd == 0.7 22:04:08 INFO - mozinfo == 0.9 22:04:08 INFO - mozleak == 0.1 22:04:08 INFO - mozlog == 3.1 22:04:08 INFO - moznetwork == 0.27 22:04:08 INFO - mozprocess == 0.22 22:04:08 INFO - mozprofile == 0.28 22:04:08 INFO - mozrunner == 6.11 22:04:08 INFO - mozscreenshot == 0.1 22:04:08 INFO - mozsystemmonitor == 0.0 22:04:08 INFO - moztest == 0.7 22:04:08 INFO - mozversion == 1.4 22:04:08 INFO - psutil == 3.1.1 22:04:08 INFO - requests == 1.2.3 22:04:08 INFO - wsgiref == 0.1.2 22:04:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:04:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:04:08 INFO - Using env: {'DISPLAY': ':0', 22:04:08 INFO - 'HOME': '/home/cltbld', 22:04:08 INFO - 'LANG': 'en_US.UTF-8', 22:04:08 INFO - 'LANGUAGE': 'en_US:en', 22:04:08 INFO - 'LOGNAME': 'cltbld', 22:04:08 INFO - 'MAIL': '/var/mail/cltbld', 22:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:08 INFO - 'MOZ_NO_REMOTE': '1', 22:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:08 INFO - 'NO_EM_RESTART': '1', 22:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:08 INFO - 'SHELL': '/bin/bash', 22:04:08 INFO - 'SHLVL': '1', 22:04:08 INFO - 'TERM': 'linux', 22:04:08 INFO - 'TMOUT': '86400', 22:04:08 INFO - 'USER': 'cltbld', 22:04:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:08 INFO - '_': '/tools/buildbot/bin/python'} 22:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:04:08 INFO - Cleaning up... 22:04:08 INFO - Return code: 0 22:04:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:04:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:04:08 INFO - Using env: {'DISPLAY': ':0', 22:04:08 INFO - 'HOME': '/home/cltbld', 22:04:08 INFO - 'LANG': 'en_US.UTF-8', 22:04:08 INFO - 'LANGUAGE': 'en_US:en', 22:04:08 INFO - 'LOGNAME': 'cltbld', 22:04:08 INFO - 'MAIL': '/var/mail/cltbld', 22:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:08 INFO - 'MOZ_NO_REMOTE': '1', 22:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:08 INFO - 'NO_EM_RESTART': '1', 22:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:08 INFO - 'SHELL': '/bin/bash', 22:04:08 INFO - 'SHLVL': '1', 22:04:08 INFO - 'TERM': 'linux', 22:04:08 INFO - 'TMOUT': '86400', 22:04:08 INFO - 'USER': 'cltbld', 22:04:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:08 INFO - '_': '/tools/buildbot/bin/python'} 22:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:08 INFO - Downloading/unpacking jsonschema 22:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:04:10 INFO - Downloading/unpacking functools32 (from jsonschema) 22:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:04:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:04:10 INFO - warning: no files found matching '*.txt' 22:04:10 INFO - no previously-included directories found matching 'build' 22:04:10 INFO - no previously-included directories found matching 'dist' 22:04:10 INFO - no previously-included directories found matching '.git*' 22:04:10 INFO - Installing collected packages: jsonschema, functools32 22:04:11 INFO - Running setup.py install for functools32 22:04:11 INFO - warning: no files found matching '*.txt' 22:04:11 INFO - no previously-included directories found matching 'build' 22:04:11 INFO - no previously-included directories found matching 'dist' 22:04:11 INFO - no previously-included directories found matching '.git*' 22:04:11 INFO - Successfully installed jsonschema functools32 22:04:11 INFO - Cleaning up... 22:04:11 INFO - Return code: 0 22:04:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b196fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21938d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', '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 22:04:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:04:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:04:11 INFO - Using env: {'DISPLAY': ':0', 22:04:11 INFO - 'HOME': '/home/cltbld', 22:04:11 INFO - 'LANG': 'en_US.UTF-8', 22:04:11 INFO - 'LANGUAGE': 'en_US:en', 22:04:11 INFO - 'LOGNAME': 'cltbld', 22:04:11 INFO - 'MAIL': '/var/mail/cltbld', 22:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:11 INFO - 'MOZ_NO_REMOTE': '1', 22:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:11 INFO - 'NO_EM_RESTART': '1', 22:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:11 INFO - 'SHELL': '/bin/bash', 22:04:11 INFO - 'SHLVL': '1', 22:04:11 INFO - 'TERM': 'linux', 22:04:11 INFO - 'TMOUT': '86400', 22:04:11 INFO - 'USER': 'cltbld', 22:04:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:11 INFO - '_': '/tools/buildbot/bin/python'} 22:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:11 INFO - Downloading/unpacking flake8 22:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:04:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:04:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:04:14 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 22:04:14 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 22:04:14 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 22:04:14 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 22:04:14 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 22:04:14 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 22:04:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:14 INFO - no previously-included directories found matching 'docs/_build' 22:04:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:04:14 INFO - Running setup.py install for pep8 22:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:04:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:04:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:04:14 INFO - no previously-included directories found matching 'docs/_build' 22:04:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:04:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:04:14 INFO - Cleaning up... 22:04:14 INFO - Return code: 0 22:04:14 INFO - Running post-action listener: _resource_record_post_action 22:04:14 INFO - Running post-action listener: _start_resource_monitoring 22:04:14 INFO - Starting resource monitoring. 22:04:14 INFO - ##### 22:04:14 INFO - ##### Running install step. 22:04:14 INFO - ##### 22:04:14 INFO - Running pre-action listener: _resource_record_pre_action 22:04:14 INFO - Running main action method: install 22:04:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:04:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:04:14 INFO - Reading from file tmpfile_stdout 22:04:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:04:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:04:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:04:14 INFO - Reading from file tmpfile_stdout 22:04:14 INFO - Output received: 22:04:14 INFO - Usage: mozinstall [options] installer 22:04:14 INFO - Options: 22:04:14 INFO - -h, --help show this help message and exit 22:04:14 INFO - -d DEST, --destination=DEST 22:04:14 INFO - Directory to install application into. [default: 22:04:14 INFO - "/builds/slave/test-pgo"] 22:04:14 INFO - --app=APP Application being installed. [default: firefox] 22:04:14 INFO - mkdir: /builds/slave/test-pgo/build/application 22:04:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:04:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:04:31 INFO - Reading from file tmpfile_stdout 22:04:31 INFO - Output received: 22:04:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:04:31 INFO - Running post-action listener: _resource_record_post_action 22:04:31 INFO - ##### 22:04:31 INFO - ##### Running run-tests step. 22:04:31 INFO - ##### 22:04:31 INFO - Running pre-action listener: _resource_record_pre_action 22:04:31 INFO - Running main action method: run_tests 22:04:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:04:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:04:31 INFO - Python 2.7.3 22:04:31 INFO - Return code: 0 22:04:31 INFO - grabbing minidump binary from tooltool 22:04:31 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')]} 22:04:31 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 0x22228b0>, '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 0x22237b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2223c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:04:31 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 22:04:31 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 22:04:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:04:31 INFO - Return code: 0 22:04:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:04:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:04:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:04:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:04:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:04:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:04:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:04:32 INFO - Return code: 0 22:04:32 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/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:04:32 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/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 22:04:32 INFO - Using env: {'DISPLAY': ':0', 22:04:32 INFO - 'HOME': '/home/cltbld', 22:04:32 INFO - 'LANG': 'en_US.UTF-8', 22:04:32 INFO - 'LANGUAGE': 'en_US:en', 22:04:32 INFO - 'LOGNAME': 'cltbld', 22:04:32 INFO - 'MAIL': '/var/mail/cltbld', 22:04:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:04:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:32 INFO - 'MOZ_NO_REMOTE': '1', 22:04:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:32 INFO - 'NO_EM_RESTART': '1', 22:04:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:04:32 INFO - 'SHELL': '/bin/bash', 22:04:32 INFO - 'SHLVL': '1', 22:04:32 INFO - 'TERM': 'linux', 22:04:32 INFO - 'TMOUT': '86400', 22:04:32 INFO - 'USER': 'cltbld', 22:04:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744', 22:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:32 INFO - '_': '/tools/buildbot/bin/python'} 22:04:32 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/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:04:32 INFO - mozversion application_buildid: 20160405193250 22:04:32 INFO - mozversion application_changeset: 496db28e275d83a8a8d57033384d18199ccbcbd9 22:04:32 INFO - mozversion application_display_name: Nightly 22:04:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:04:32 INFO - mozversion application_name: Firefox 22:04:32 INFO - mozversion application_remotingname: firefox 22:04:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:04:32 INFO - mozversion application_vendor: Mozilla 22:04:32 INFO - mozversion application_version: 48.0a1 22:04:32 INFO - mozversion platform_buildid: 20160405193250 22:04:32 INFO - mozversion platform_changeset: 496db28e275d83a8a8d57033384d18199ccbcbd9 22:04:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:04:32 INFO - mozversion platform_version: 48.0a1 22:04:32 INFO - using testdate: 1459919072 22:04:32 INFO - actual date: 1459919072 22:04:32 INFO - starting webserver on 'localhost:51974' 22:04:32 INFO - SUITE-START | Running 2 tests 22:04:32 INFO - TEST-START | dromaeo_css 22:04:32 INFO - operating with platform_type : linux_ 22:04:32 INFO - Initialising browser for dromaeo_css test... 22:04:32 INFO - TEST-INFO | started process 11909 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOpFUIi/profile http://localhost:51974/getInfo.html) 22:04:36 INFO - PROCESS | 11909 | __metrics Screen width/height:1600/1200 22:04:36 INFO - PROCESS | 11909 | colorDepth:24 22:04:36 INFO - PROCESS | 11909 | Browser inner width/height: 1024/697 22:04:36 INFO - PROCESS | 11909 | __metrics 22:04:37 ERROR - PROCESS | 11909 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:04:38 INFO - TEST-INFO | 11909: exit 0 22:04:38 INFO - Browser initialized. 22:04:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:04:38 INFO - TEST-INFO | started process 11989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOpFUIi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:04:50 INFO - PROCESS | 11989 | RSS: Main: 152596480 22:04:50 INFO - PROCESS | 11989 | 22:05:40 INFO - PROCESS | 11989 | 1459919140823 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] 22:07:48 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51974/tests/dromaeo/cssquery-ext.html) 22:07:49 INFO - PROCESS | 11989 | RSS: Main: 286146560 22:07:49 INFO - PROCESS | 11989 | 22:10:51 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-ext.html (next: http://localhost:51974/tests/dromaeo/cssquery-jquery.html) 22:10:52 INFO - PROCESS | 11989 | RSS: Main: 231628800 22:10:52 INFO - PROCESS | 11989 | 22:13:54 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51974/tests/dromaeo/cssquery-mootools.html) 22:13:54 INFO - PROCESS | 11989 | RSS: Main: 224800768 22:13:54 INFO - PROCESS | 11989 | 22:16:56 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51974/tests/dromaeo/cssquery-prototype.html) 22:16:57 INFO - PROCESS | 11989 | RSS: Main: 212086784 22:16:57 INFO - PROCESS | 11989 | 22:19:59 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51974/tests/dromaeo/cssquery-yui.html) 22:20:00 INFO - PROCESS | 11989 | RSS: Main: 198631424 22:20:00 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | Cycle 1(1): loaded http://localhost:51974/tests/dromaeo/cssquery-yui.html (next: http://localhost:51974/tests/dromaeo/cssquery-dojo.html) 22:23:02 INFO - PROCESS | 11989 | RSS: Main: 264699904 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | __start_tp_report 22:23:02 INFO - PROCESS | 11989 | _x_x_mozilla_page_load 22:23:02 INFO - PROCESS | 11989 | _x_x_mozilla_page_load_details 22:23:02 INFO - PROCESS | 11989 | |i|pagename|runs| 22:23:02 INFO - PROCESS | 11989 | |0;dojo.html;3046.49732794089;3080.3377273886126;3081.245094951737;3106.7048630380114;3108.891188808392;4990.75046247688;5224.29472021277;5234.7120908350025;5242.292290540776;5329.467053294668;5269.104252277112;5360.517553420192;5373.301470808799;5382.3541175059045;5383.273258110154;4777.259524773665;4791.976040119795;4814.109389762905;4848.466668666444;4960.727160006199;4886.096072226649;4909.7790599423115;4939.50604939505;4954.87612809679;4982.128127577677;4803.975980120112;4829.251466022754;4895.0209958008545;4916.213405855082;4920.089783390066;4731.716097034189;4734.786934587952;4749.691270067435;4795.568398844086;4828.806847726087;4727.787249573743;4728.787204575802;4741.905161896742;4750.073735621555;4772.952270477285;5132.3327967364;5145.33110695611;5146.716930568818;5235.764390602432;5241.737913104368;5671.120976248688;5718.971405142947;5719.885602287931;5720.256366672347;5726.284214473191;5741.397153298927;5765;5767.192593036978;5782.913256301159;5784.045632470637;5119.564836988823;5351.438098999627;5396.83809485716;5422.620416570841;5445.945540544623;5701.4013528579735;5704.3154821421695;5705.857353566194;5705.942940570624;5723.141528770718;5550.361708403505;5551;5552;5556.222128901957;5605.355384130796;5498.697571633518;5607.635503692247;5673.063944449203;5705.343885453143;5720.456556627114;5636.859078522988;5640.153976903497;5664.518515926193;5675.460831221028;5678.801241956512;5450.8909821803345;5635.8591035224445;5656.434356564393;5690.4025077367105;5704.172894930211;4225.661947044229;4264.04059086703;4267.381229721673;4279.914401712011;4297.82808687649;3847.442120892511;3862.5944275851193;3874.6319099685484;3896.2402331545645;3905.1018265798457;5285.762140703678;5390.9191362129595;5391.137418013099;5398.24424580559;5401.378841433207;5713.285839270091;5740.68426236561;5761.711914404263;5798.420157984252;5812.767489300465;5321.068812957717;5323.1749078892835;5324.813631522956;5329.280547126166;5338.145896656516;4768.594669453136;4863.781129849165;4865.0756356292195;4901.485344038824;4929.186684197068;5809.24479817621;5823.82528524145;5825.0679891217205;5828.329742079631;5874.206982057368;5610.971945140248;5626.915596266142;5634.774609015593;5636.126400407943;5649.632773869767;5694.259746232963;5783.913241301468;5784.623999440023;5821.388754180919;5864.266966629171;5633.436656334334;5638.379778224474;5639.3232812062815;5646.632968857011;5660.179274005329;5685.744141513559;5692.686902220417;5722.141678748221;5726.685032323262;5727.1695604138;5342.78628854857;5485.4788795064405;5552.750126244409;5612.438756124355;5626.690532020778;5559.833205003856;5582.274304340573;5589.357223919139;5593.105103183471;5594.1608758686525;5495.5878309127775;5518.530924871431;5519.448055194448;5522.641028333145;5574.275344205227;5441.428649991693;5470.288862447856;5518.42056584069;5555.694436805853;5628.60599758013;5412.675239485643;5433.049216387038;5475.917861232165;5498.092814685532;5500.339959204921 22:23:02 INFO - PROCESS | 11989 | |1;ext.html;540.2196228433136;556.7745063249386;568.0286709726367;580.8199458167966;586.7037146241148;29230.269243268904;29624.999999999945;29662.999999999975;29693.257668558268;36928.630713692924;39880.80059599698;40524.39213411794;40572;40628.59371406285;40685.389719154235;8577.142285771404;8773.122687731207;8781.824363512726;8783.912160878404;8788.16512431318;8559.358048146414;8621.698240561582;8690.695825646104;8716.912830871705;8721.738347849574;8545.829083418328;8636.352273579476;8674.392792504526;8702.086280940504;8944.821103577924;8826.42628229163;8884.644614215424;8887;8900.910990890074;8901.154390332907;8777.473351598861;8876.778080547974;8893.421927574687;8900.51047192404;8901.777455563599;40640.39039414411;41253.79373103145;41293.58706412927;41298;41299.38050929239;3428.63999280077;3540.2565461253166;3620.8732694355836;3824.4836947012354;4169.082801783603;31608.525872111706;31912.521312180335;32181.356372872644;32196.678033219836;33080.669193308;3920.823562939646;3930.2728995135703;3956.4065390191413;4102.179564087194;4229.006183546864;290704;292363;292703;293632;294788.5260573705;52860.20709689358;58760.41239587549;59035;59075.40924590785;60279.397206028254;54932.725336373864;55235;55352;55356.44643553513;55368;16009.679806403807;16399.344026239054;16436.6712665746;16451.095189764677;16457.09485978283;11865.822012669816;12568.120231583702;12626.747465050832;12689.302088385042;12816.551420700418;18969.146388412555;19071.52321191981;19180.520486987938;19197.712034319495;19228.519287017658;7001.929980700128;7003.649817509104;7074.823129421703;7100.3254690805325;7105.502614817016;1043.160255993917;1091.2633972068822;1121.775644871029;1131.99838570654;1136.7499150186945;30521;31381.37237255242;31524.527132093037;31731.841340793148;31994.360112797614;1091.6943255888364;1196.8623608284984;1201.5253974679952;1231.347385885482;1301.7461594988886;16141.112238826978;16438.83561164373;16467.58831029234;16489.6702065958;16578.917105414635;380367;384892;385494;386018;386242;55190;55442.16836747452;55461.44538554644;55543.44456555464;55554.16668749972;1301.8828305452555;1329.2489743295007;1349.0286993364762;1384.1279993604167;1394.28194479845;27485.450290994468;28398.85800570984;29019;29179;29505.409891801613;38405.23189536249;38647.26087326133;38795.2240955185;39335.803320983214;39339.409908850816;193669;194858;195441;195850;196744;33853.49219761755;34508.13729656678;34992.30015399627;35006.47490287699;35009.29981400409;43743.25026998884;44178.55821441873;44386.778066109466;44471.777641111585;45369.09261814811;37343.2531349366;37679;37803.35376523617;37889;38137.237255254186;37201.81399092987;37724.24551509009;37851.810740946115;37908.24183516259;38069.619303806605;37105;37331.253374932894;37944;37953.05117372088;38112.04719882025;31691.52462713015;32828.67171328256;33475.83262083674;33609;33921;25488.872555637103;26466.86766566155;26503.60244596294;26581.60127598049;26593.601095983187 22:23:02 INFO - PROCESS | 11989 | |2;jquery.html;358.8887444892083;363.6254657702567;366.95413073365825;367.2159938531235;368.0944875606009;17137.742933856003;17254;18141.365052223176;18194;18221.544461388472;17142.742858857127;17509.562260943483;17515.12424378779;17520.82479175208;17544.298228070893;5056.797728090872;5503.642263252896;5504.422035686255;5507.03626865299;5507.118860982244;3947;4051.331530297512;4052.5947405259385;4055.5944405559503;5407.3781515125875;5786.652800831943;5976.940230597704;6002.699865006754;6007.579469437119;6020.367861374536;5781.682007489587;5980.970095149518;6138.662373569452;6148.538859585504;6150.692465376758;3646.161382881952;5453.045716999509;5458.2904222451225;5463.590230732671;5483.972580137074;18979.62040759191;19559.217631294872;19682.80317196824;19763.802361976483;20520;2253.4816992091746;2343.988280058606;2344.800691941187;2498.5781052943976;3022.8966427254113;13089.672758181026;13545.932270338684;13667.794983075262;13669.589912302647;13717.314134293245;1919.712043193532;1955.4231501706888;1970.0346830053313;1975.8638782699861;2004.8696834705697;68047.65976170138;68681.31318686799;68897.65551172211;69583.30416695819;70937;9091.27269818413;9343.159115679622;9547.713568592953;9570.980188320922;9669.70990870275;12603.306818124907;12609.495620175274;12669.93665031669;12687.429065692066;12770.297633630054;7635.389168866477;7636.69453221876;7953.204679532;7988.241117093867;8054.879176812353;7885.250901164381;7942.444028918036;7964.20357964199;8060.596970151469;8084.878726819103;5847.795327163614;5849.970750146307;5939.673317967553;6020.096985452217;6037.400088976425;1635.5747505648617;1692.8053273873415;1725.6203635200236;1730.5846596816925;1760.5774614092782;955.6607404371348;1045.7019749371393;1071.8928107189374;1170.2627344772739;1171.297221666993;17124.914375428045;17527.824721752873;18038.007909564836;18230.179641916147;18280.725789113174;1017.9694609161737;1040.6773900090845;1077.8975997280402;1102.2119184782919;1128.729105014807;10597.523111460003;10736.30214036085;10753;10763.623273185402;10777.407242601575;474573;484638;485703;488608;492284;67962;70505;70817;70919;70993;1093.10365500289;1094.370736826328;1098.5111625326813;1107.595727559451;1108.7449886526144;16403.91798041002;16408.26162822652;16409.343626254817;16417.835821642107;16629.75055374146;32557.674423255463;32798.18004549905;32972.835135825124;33195.336093278485;33481;42514.362960459715;44033.339499906884;44122.33816492691;44143.779281104675;44186.55813441953;7588;7691.269329413921;7769.339606133542;7776.922230777846;7794.454388192772;12379.69050773738;12544.996400288137;12625.179363341353;12690.428930697955;12795.232286062866;10643.095336896451;10745;10934.398608076313;11165.162612804235;11321.320720756781;10258.12805911476;10893.346399216072;10947.178961577754;10999.34003959765;11233.550657973916;10796.946015269874;10811.189160812813;11044.779104418027;11348.943255284;11465.656030319104;7663.616819158909;7761.301482866569;7786.7663970080985;7912.723054693058;7937.523748575104;10631.521581529005;11261.268017578832;11330.60342887995;11634.36011019402;11657.125715571197 22:23:02 INFO - PROCESS | 11989 | |3;mootools.html;1475.6089636246393;1502.0462006625792;1678.2951160512584;1798.4424828303236;1819.1722766141415;7812.843743125134;8089.676412943475;8090.474119182249;8096.028476582811;8097;6979.441644668427;7590.392768578514;7814.296713295802;7834.569098699583;8069.03171619405;2272.034385386208;2307.8153747700144;2308.1113771198125;2309.2725791375665;2311.4221444638843;2002.7496562929634;2311.641695537194;2311.7919387255142;2359.681443005198;2366.9408264793346;2249.3364457485;2297.7587353327913;2302.458922153293;2303.0787684925995;2308.411355104446;2260.2541161416693;2272.625016872214;2332.6267797152545;2335.2877372401413;2338.123203798584;2237.7314722233436;2248.2580748353002;2261.479859632277;2292.713410823647;2292.747797742247;7911.564863932482;7960.880586791202;7962.920370796276;8084.312833409167;8106.310963568104;5036.622253331015;5109.897802043938;5122.590192784568;5157.510036546522;5167.354080739908;3355.144438168276;3439.8624055037767;3460.567429071366;3478.9389236282923;3512.701420379271;1122.6183097746805;1176.1237877781107;1181.551010615969;1215.6231568213793;1224.381687247943;11207.775844483065;11229.3262404256;11234.49444774987;11238.325700457917;11252.043576296024;4503.954960450354;4545.38637283969;4616.238320677118;4626.0979109073405;4633.374494443275;9556.283278754121;9565.234781217487;9566.56950437232;9570.856437153448;9583.329166958385;5137.563307118862;5146.099432599281;5169.276301317818;5186.5850731941355;5191.9480805192225;4759.119562880878;4767.141914455362;4767.4517430495935;4772.093302272557;4774.045190961821;3751.1372384351753;3890.922181556353;3912.550056743511;3919.8432062717743;3930.1746633206776;1146.9770604587861;1248.1637303007008;1253.2042153232762;1269.4033804112053;1276.942537585811;1127.1771606727134;1153.6942710181809;1167.258790667932;1172.8827117288204;1178.452019810792;7590.3927685785;7654.4259180561685;7685.269899359552;7714;7733.690652373954;1077.2459278505078;1090.574675876409;1121.685927940178;1138.4023387721513;1171.9531218751154;6139.2325959255095;6148.938510614926;6188.938110618837;6196.47329976948;6200.782972595937;9198.356115071882;9977.650782222587;9984.80030399388;10119;10124.240681948882;9829.508524573886;9881.703548893545;9952.900470995197;9978.550965206583;9991.550380232908;7441.925580744123;7890.842183156305;7901.209879012168;7902.486338388101;7906.05127384706;7331.926680733338;7387.741429049957;7397.963010184914;7414.777556673308;7420.332170104716;8592.140785921358;8793.384463087523;8901.421407608485;8910.287177025693;9060.093990600888;8774.385792994684;8833.646654133763;9018.188363047357;9019.77450563715;9031.638734450811;7297.379722723628;7348.1182258129365;7396.778096657109;7399.852002960019;7401.481896267425;7469.290417410337;7622.466427350032;7870.055593328837;7920.920790792249;7932.04815422153;7094.53885497441;7138.678759455941;7140.7857764267155;7234.74678386254;7235.095613048369;5955.553333499918;6933.4106600939485;6986.161660600557;7040.507164498641;7063.470239731938;7421.517601355895;7493.025906632103;7494.100707915085;7498.58757768328;7521.473496855387;6845.315468453115;6947.826304342432;6968.547044442095;6970.407515361251;6973.895391569232;6977.616231107338;6986.301369862973;6999.195092564217;7018.613976231152;7033.824154396181 22:23:02 INFO - PROCESS | 11989 | |4;prototype.html;335.7079340973353;336.8635702540472;338.7154789976419;341.4809489575845;347.94606835940425;6057.697115144236;6061.7575296988125;6077.848053798657;6083.817485475437;6120.969395153018;6047.818565443033;6072.54455915807;6074.939250607493;6077.11881777142;6084.330723620398;4452.777361131946;4557.9772101139615;4625.213713668668;4660.370849935266;4681.953180468203;4686.109639168564;4690.484046754854;4696.553827386393;4696.906061878761;4705.106029854317;4652.604528615072;4653.418322709661;4658.440987081538;4667.603253723438;4670.065986802636;4444.799984000711;4507.819687212491;4544.136614043321;4557.931631025537;4558.9772051139535;4004.1391100913443;4021.195760847842;4026.7583944963103;4027;4032.213718324928;5688.402717714663;5735.082386818089;5760.279965004374;5762.366139724627;5766;5347.759350829183;5351.7056561889085;5354.223637572569;5356.6518176318805;5361.758720857571;6311.116443697886;6313.526485513559;6314.747410103636;6322.367763223687;6323.462505687022;4244.787760611957;4382.211201983641;4382.255016647177;4386.627136693385;4495.685302028859;6567.868642627121;6568.507361947873;6586.967065164691;6618.503612229102;6630.900536491957;4439.045605194834;4487.798049087799;4489;4491.483479399845;4497.415336006298;4540.364348991144;4546.863594092182;4547.681662283675;4557.088582283556;4557.612602928788;5278.894422111536;5286.07493688603;5289.70906600133;5293.973530132324;5295.311609490818;6277.843053923597;6451.29035806061;6467.223933128054;6480.351964803576;6500.187476565429;1582.8654564361927;1594.067470529753;1595.13862514241;1600.3758534171682;1604.4865642994364;993.7465946183677;1000.3047881722133;1030.294248439821;1048.6591857646295;1051.7265510967204;6084.726187321493;6128.080787881764;6128.356522565066;6234;6276.340984196685;6678.899816502756;6688.431483323875;6691.096701945273;6697.7655782047395;6703.966480167665;6240.157578726905;6253.593516421418;6254.499640028786;6264.436200741864;6266.780662676875;3558.644135586472;3595.0293420776243;3597.5323207982797;3602.3875941089555;3604.2611264690677;6574.211094668671;6624.701888414937;6640.335966403321;6642.800715978528;6818.624975626289;6493.577917435352;6613.669316534154;6643.833904152435;6653.168353955755;6703.12859328294;6645.640797517005;6702.463802895757;6872;6884.51808373409;6891.793246202722;6643.368879956396;6649.900251496329;6649.966750166218;6655.866882662222;6668.733250669919;6574.11249481333;6576.506761992965;6581.539292249497;6584.76953306632;6597.637129957899;6908.1019467468905;6910.7581234656545;6918.481113916577;6925.27284635106;6925.89611155823;4459.085887393141;4493.865184044484;4496.505384407647;4499.302608095751;4502.3471596618965;6353.491720662429;6361.936380636134;6456.709448074942;6461.418472337512;6631.303713110054;6441.645709486023;6453.257875344396;6453.935460645521;6461.773837915838;6475.902861457176;6437.645929473924;6441.903371449338;6443.387878151568;6445.581037232565;6448.806535803933;6329.715162817776;6331.620102793847;6349.904751428639;6357;6364.268109167505;6315.96842015787;6475.255345635313;6480.351964803482;6492.610443373413;6494.870102597827;6275.152854364603;6318.147050148171;6324.873502530016;6337.271213810286;6346.524010699309 22:23:02 INFO - PROCESS | 11989 | |5;yui.html;732.2165283147035;786.7954331873715;798.034378402133;808.656321063548;851.4891065360785;14191.787123193148;14431.350589223484;14439.06146100504;14470.421183152674;14578.271086445688;12621.62135135945;13482.056256062055;13885.791713124312;13911.443542258323;13914.30428478577;793.5595744361891;801.0667572278289;802.9718959836407;807.1444269074799;808.1756608259572;783.8001309666056;784.4077721320396;785.2657764989724;785.7721260834351;786.830831371255;855.589317127779;856.178069053706;856.3962406503431;857.5497863621587;857.7684025313193;850.740524140137;850.961706723199;853.5604163855619;853.632937836733;854.0093491549803;618.5700937848197;619.3806193806194;619.9132121502993;620.6555361774259;621.3382747374033;11817.468213930308;11857;11886.108541859308;11899.405029748477;12010.69973250667;11307.321560706301;11367.658970230907;11488.253263537843;11509.769804603944;11715.765684686345;10718.785624287471;12479.31363775001;12553.121281510297;12611.810822837664;12694.746105077938;4492.460904691426;4535.365048893158;4630.513796051399;4634.142683603511;4727.598154156901;47677.523224767654;48191.03617927657;48588.51411485875;48714.26928596074;49042;10773.569057237779;10850.29473084247;10865.83701244482;10914.672559823059;11006.284591501688;18705.81294187041;18706.625867482573;18727.81272187288;18731.25074997012;18977.43067707971;8176.672933082729;8200.83598328042;8204.83590328202;8383.077861435237;8488.278496327757;4831.371921650233;4843;4858.902821943541;4906.092372911023;5121.2574176744165;3305.190228394059;3327.2680010397676;3328.1679580104974;3330.2673411849355;3350.0452371074125;593.902006168986;598.1536126381209;610.5420934299276;613.8373331067271;621.1521273461783;736.988945165823;740.0859937976595;743.8028922335585;753.6985205917676;768.673313841615;8748.91251087481;9227.645108949951;9307.348485605942;9491.430514169035;9733.318667693335;561.2871653000666;647.2104033079635;676.3338111959715;715.992840071603;724.9565026098451;4067.2068946555137;4241.1941731071;4516.187086324493;4529.501754806968;4598.494165641777;57207;58511;58900;59170.704146478995;59221;43413.34879976803;50954.490455095714;51395.229071563954;54471;54901;47996.760016200395;48120.27819582709;48204.5179548207;48263.27605085926;49131.263031054565;9933.950330248303;10078.244131690299;10084.394936303845;10146.53905722578;10174.491275436347;36598.26803463969;36823.815880920425;37648.623513765604;37783;38225.61774382221;45056.549434505236;45818.541814581426;45877;46573.767131164124;46847.76576117097;12138.150329477205;12215.755684886075;12263.26420414778;12374.81437778416;12394;13540.241137160543;13724.862751372759;13958.930205348908;14083.155010699391;14171.362288696828;12960.935195323964;13052.412641430969;13062.150960187937;13067.607971760863;13144.40850161726;12449.564265251034;12626.936865315982;12642.115051946275;12849.164804287691;12974.870251297367;12833.358332083546;13207.471701131846;13410.32948352559;13715.382807773474;13749.931250343685;10711.357318560911;10865.674029779118;10973.835392469278;11064.502097405475;11114.833277500682;10571.36571805694;10634.84047739269;10678.946605266923;10697.679069627924;10784.759752628235 22:23:02 INFO - PROCESS | 11989 | __end_tp_report 22:23:02 INFO - PROCESS | 11989 | __start_cc_report 22:23:02 INFO - PROCESS | 11989 | _x_x_mozilla_cycle_collect,1080 22:23:02 INFO - PROCESS | 11989 | __end_cc_report 22:23:02 INFO - PROCESS | 11989 | __startTimestamp1459920182901__endTimestamp 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | ------- Summary: start ------- 22:23:02 INFO - PROCESS | 11989 | Number of tests: 6 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#0] dojo.html Cycles:165 Average:5263.99 Median:5485.48 stddev:598.72 (10.9%) stddev-sans-first:574.73 22:23:02 INFO - PROCESS | 11989 | Values: 3046.5 3080.3 3081.2 3106.7 3108.9 4990.8 5224.3 5234.7 5242.3 5329.5 5269.1 5360.5 5373.3 5382.4 5383.3 4777.3 4792.0 4814.1 4848.5 4960.7 4886.1 4909.8 4939.5 4954.9 4982.1 4804.0 4829.3 4895.0 4916.2 4920.1 4731.7 4734.8 4749.7 4795.6 4828.8 4727.8 4728.8 4741.9 4750.1 4773.0 5132.3 5145.3 5146.7 5235.8 5241.7 5671.1 5719.0 5719.9 5720.3 5726.3 5741.4 5765.0 5767.2 5782.9 5784.0 5119.6 5351.4 5396.8 5422.6 5445.9 5701.4 5704.3 5705.9 5705.9 5723.1 5550.4 5551.0 5552.0 5556.2 5605.4 5498.7 5607.6 5673.1 5705.3 5720.5 5636.9 5640.2 5664.5 5675.5 5678.8 5450.9 5635.9 5656.4 5690.4 5704.2 4225.7 4264.0 4267.4 4279.9 4297.8 3847.4 3862.6 3874.6 3896.2 3905.1 5285.8 5390.9 5391.1 5398.2 5401.4 5713.3 5740.7 5761.7 5798.4 5812.8 5321.1 5323.2 5324.8 5329.3 5338.1 4768.6 4863.8 4865.1 4901.5 4929.2 5809.2 5823.8 5825.1 5828.3 5874.2 5611.0 5626.9 5634.8 5636.1 5649.6 5694.3 5783.9 5784.6 5821.4 5864.3 5633.4 5638.4 5639.3 5646.6 5660.2 5685.7 5692.7 5722.1 5726.7 5727.2 5342.8 5485.5 5552.8 5612.4 5626.7 5559.8 5582.3 5589.4 5593.1 5594.2 5495.6 5518.5 5519.4 5522.6 5574.3 5441.4 5470.3 5518.4 5555.7 5628.6 5412.7 5433.0 5475.9 5498.1 5500.3 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#1] ext.html Cycles:180 Average:46232.80 Median:37870.41 stddev:79067.63 (208.8%) stddev-sans-first:79215.01 22:23:02 INFO - PROCESS | 11989 | Values: 540.2 556.8 568.0 580.8 586.7 29230.3 29625.0 29663.0 29693.3 36928.6 39880.8 40524.4 40572.0 40628.6 40685.4 8577.1 8773.1 8781.8 8783.9 8788.2 8559.4 8621.7 8690.7 8716.9 8721.7 8545.8 8636.4 8674.4 8702.1 8944.8 8826.4 8884.6 8887.0 8900.9 8901.2 8777.5 8876.8 8893.4 8900.5 8901.8 40640.4 41253.8 41293.6 41298.0 41299.4 3428.6 3540.3 3620.9 3824.5 4169.1 31608.5 31912.5 32181.4 32196.7 33080.7 3920.8 3930.3 3956.4 4102.2 4229.0 290704.0 292363.0 292703.0 293632.0 294788.5 52860.2 58760.4 59035.0 59075.4 60279.4 54932.7 55235.0 55352.0 55356.4 55368.0 16009.7 16399.3 16436.7 16451.1 16457.1 11865.8 12568.1 12626.7 12689.3 12816.6 18969.1 19071.5 19180.5 19197.7 19228.5 7001.9 7003.6 7074.8 7100.3 7105.5 1043.2 1091.3 1121.8 1132.0 1136.7 30521.0 31381.4 31524.5 31731.8 31994.4 1091.7 1196.9 1201.5 1231.3 1301.7 16141.1 16438.8 16467.6 16489.7 16578.9 380367.0 384892.0 385494.0 386018.0 386242.0 55190.0 55442.2 55461.4 55543.4 55554.2 1301.9 1329.2 1349.0 1384.1 1394.3 27485.5 28398.9 29019.0 29179.0 29505.4 38405.2 38647.3 38795.2 39335.8 39339.4 193669.0 194858.0 195441.0 195850.0 196744.0 33853.5 34508.1 34992.3 35006.5 35009.3 43743.3 44178.6 44386.8 44471.8 45369.1 37343.3 37679.0 37803.4 37889.0 38137.2 37201.8 37724.2 37851.8 37908.2 38069.6 37105.0 37331.3 37944.0 37953.1 38112.0 31691.5 32828.7 33475.8 33609.0 33921.0 25488.9 26466.9 26503.6 26581.6 26593.6 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#2] jquery.html Cycles:180 Average:26883.17 Median:2344.39 stddev:79343.65 (3384.4%) stddev-sans-first:79541.24 22:23:02 INFO - PROCESS | 11989 | Values: 358.9 363.6 367.0 367.2 368.1 17137.7 17254.0 18141.4 18194.0 18221.5 17142.7 17509.6 17515.1 17520.8 17544.3 5056.8 5503.6 5504.4 5507.0 5507.1 3947.0 4051.3 4052.6 4055.6 5407.4 5786.7 5976.9 6002.7 6007.6 6020.4 5781.7 5981.0 6138.7 6148.5 6150.7 3646.2 5453.0 5458.3 5463.6 5484.0 18979.6 19559.2 19682.8 19763.8 20520.0 2253.5 2344.0 2344.8 2498.6 3022.9 13089.7 13545.9 13667.8 13669.6 13717.3 1919.7 1955.4 1970.0 1975.9 2004.9 68047.7 68681.3 68897.7 69583.3 70937.0 9091.3 9343.2 9547.7 9571.0 9669.7 12603.3 12609.5 12669.9 12687.4 12770.3 7635.4 7636.7 7953.2 7988.2 8054.9 7885.3 7942.4 7964.2 8060.6 8084.9 5847.8 5850.0 5939.7 6020.1 6037.4 1635.6 1692.8 1725.6 1730.6 1760.6 955.7 1045.7 1071.9 1170.3 1171.3 17124.9 17527.8 18038.0 18230.2 18280.7 1018.0 1040.7 1077.9 1102.2 1128.7 10597.5 10736.3 10753.0 10763.6 10777.4 474573.0 484638.0 485703.0 488608.0 492284.0 67962.0 70505.0 70817.0 70919.0 70993.0 1093.1 1094.4 1098.5 1107.6 1108.7 16403.9 16408.3 16409.3 16417.8 16629.8 32557.7 32798.2 32972.8 33195.3 33481.0 42514.4 44033.3 44122.3 44143.8 44186.6 7588.0 7691.3 7769.3 7776.9 7794.5 12379.7 12545.0 12625.2 12690.4 12795.2 10643.1 10745.0 10934.4 11165.2 11321.3 10258.1 10893.3 10947.2 10999.3 11233.6 10796.9 10811.2 11044.8 11348.9 11465.7 7663.6 7761.3 7786.8 7912.7 7937.5 10631.5 11261.3 11330.6 11634.4 11657.1 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#3] mootools.html Cycles:180 Average:5734.34 Median:6192.71 stddev:2953.80 (47.7%) stddev-sans-first:2944.74 22:23:02 INFO - PROCESS | 11989 | Values: 1475.6 1502.0 1678.3 1798.4 1819.2 7812.8 8089.7 8090.5 8096.0 8097.0 6979.4 7590.4 7814.3 7834.6 8069.0 2272.0 2307.8 2308.1 2309.3 2311.4 2002.7 2311.6 2311.8 2359.7 2366.9 2249.3 2297.8 2302.5 2303.1 2308.4 2260.3 2272.6 2332.6 2335.3 2338.1 2237.7 2248.3 2261.5 2292.7 2292.7 7911.6 7960.9 7962.9 8084.3 8106.3 5036.6 5109.9 5122.6 5157.5 5167.4 3355.1 3439.9 3460.6 3478.9 3512.7 1122.6 1176.1 1181.6 1215.6 1224.4 11207.8 11229.3 11234.5 11238.3 11252.0 4504.0 4545.4 4616.2 4626.1 4633.4 9556.3 9565.2 9566.6 9570.9 9583.3 5137.6 5146.1 5169.3 5186.6 5191.9 4759.1 4767.1 4767.5 4772.1 4774.0 3751.1 3890.9 3912.6 3919.8 3930.2 1147.0 1248.2 1253.2 1269.4 1276.9 1127.2 1153.7 1167.3 1172.9 1178.5 7590.4 7654.4 7685.3 7714.0 7733.7 1077.2 1090.6 1121.7 1138.4 1172.0 6139.2 6148.9 6188.9 6196.5 6200.8 9198.4 9977.7 9984.8 10119.0 10124.2 9829.5 9881.7 9952.9 9978.6 9991.6 7441.9 7890.8 7901.2 7902.5 7906.1 7331.9 7387.7 7398.0 7414.8 7420.3 8592.1 8793.4 8901.4 8910.3 9060.1 8774.4 8833.6 9018.2 9019.8 9031.6 7297.4 7348.1 7396.8 7399.9 7401.5 7469.3 7622.5 7870.1 7920.9 7932.0 7094.5 7138.7 7140.8 7234.7 7235.1 5955.6 6933.4 6986.2 7040.5 7063.5 7421.5 7493.0 7494.1 7498.6 7521.5 6845.3 6947.8 6968.5 6970.4 6973.9 6977.6 6986.3 6999.2 7018.6 7033.8 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#4] prototype.html Cycles:180 Average:5351.60 Median:6128.22 stddev:1621.51 (26.5%) stddev-sans-first:1581.75 22:23:02 INFO - PROCESS | 11989 | Values: 335.7 336.9 338.7 341.5 347.9 6057.7 6061.8 6077.8 6083.8 6121.0 6047.8 6072.5 6074.9 6077.1 6084.3 4452.8 4558.0 4625.2 4660.4 4682.0 4686.1 4690.5 4696.6 4696.9 4705.1 4652.6 4653.4 4658.4 4667.6 4670.1 4444.8 4507.8 4544.1 4557.9 4559.0 4004.1 4021.2 4026.8 4027.0 4032.2 5688.4 5735.1 5760.3 5762.4 5766.0 5347.8 5351.7 5354.2 5356.7 5361.8 6311.1 6313.5 6314.7 6322.4 6323.5 4244.8 4382.2 4382.3 4386.6 4495.7 6567.9 6568.5 6587.0 6618.5 6630.9 4439.0 4487.8 4489.0 4491.5 4497.4 4540.4 4546.9 4547.7 4557.1 4557.6 5278.9 5286.1 5289.7 5294.0 5295.3 6277.8 6451.3 6467.2 6480.4 6500.2 1582.9 1594.1 1595.1 1600.4 1604.5 993.7 1000.3 1030.3 1048.7 1051.7 6084.7 6128.1 6128.4 6234.0 6276.3 6678.9 6688.4 6691.1 6697.8 6704.0 6240.2 6253.6 6254.5 6264.4 6266.8 3558.6 3595.0 3597.5 3602.4 3604.3 6574.2 6624.7 6640.3 6642.8 6818.6 6493.6 6613.7 6643.8 6653.2 6703.1 6645.6 6702.5 6872.0 6884.5 6891.8 6643.4 6649.9 6650.0 6655.9 6668.7 6574.1 6576.5 6581.5 6584.8 6597.6 6908.1 6910.8 6918.5 6925.3 6925.9 4459.1 4493.9 4496.5 4499.3 4502.3 6353.5 6361.9 6456.7 6461.4 6631.3 6441.6 6453.3 6453.9 6461.8 6475.9 6437.6 6441.9 6443.4 6445.6 6448.8 6329.7 6331.6 6349.9 6357.0 6364.3 6316.0 6475.3 6480.4 6492.6 6494.9 6275.2 6318.1 6324.9 6337.3 6346.5 22:23:02 INFO - PROCESS | 11989 | 22:23:02 INFO - PROCESS | 11989 | [#5] yui.html Cycles:180 Average:14490.90 Median:4532.43 stddev:16215.00 (357.8%) stddev-sans-first:16227.57 22:23:02 INFO - PROCESS | 11989 | Values: 732.2 786.8 798.0 808.7 851.5 14191.8 14431.4 14439.1 14470.4 14578.3 12621.6 13482.1 13885.8 13911.4 13914.3 793.6 801.1 803.0 807.1 808.2 783.8 784.4 785.3 785.8 786.8 855.6 856.2 856.4 857.5 857.8 850.7 851.0 853.6 853.6 854.0 618.6 619.4 619.9 620.7 621.3 11817.5 11857.0 11886.1 11899.4 12010.7 11307.3 11367.7 11488.3 11509.8 11715.8 10718.8 12479.3 12553.1 12611.8 12694.7 4492.5 4535.4 4630.5 4634.1 4727.6 47677.5 48191.0 48588.5 48714.3 49042.0 10773.6 10850.3 10865.8 10914.7 11006.3 18705.8 18706.6 18727.8 18731.3 18977.4 8176.7 8200.8 8204.8 8383.1 8488.3 4831.4 4843.0 4858.9 4906.1 5121.3 3305.2 3327.3 3328.2 3330.3 3350.0 593.9 598.2 610.5 613.8 621.2 737.0 740.1 743.8 753.7 768.7 8748.9 9227.6 9307.3 9491.4 9733.3 561.3 647.2 676.3 716.0 725.0 4067.2 4241.2 4516.2 4529.5 4598.5 57207.0 58511.0 58900.0 59170.7 59221.0 43413.3 50954.5 51395.2 54471.0 54901.0 47996.8 48120.3 48204.5 48263.3 49131.3 9934.0 10078.2 10084.4 10146.5 10174.5 36598.3 36823.8 37648.6 37783.0 38225.6 45056.5 45818.5 45877.0 46573.8 46847.8 12138.2 12215.8 12263.3 12374.8 12394.0 13540.2 13724.9 13958.9 14083.2 14171.4 12960.9 13052.4 13062.2 13067.6 13144.4 12449.6 12626.9 12642.1 12849.2 12974.9 12833.4 13207.5 13410.3 13715.4 13749.9 10711.4 10865.7 10973.8 11064.5 11114.8 10571.4 10634.8 10678.9 10697.7 10784.8 22:23:02 INFO - PROCESS | 11989 | -------- Summary: end -------- 22:23:02 INFO - PROCESS | 11989 | 22:23:03 INFO - TEST-INFO | 11989: exit 0 22:23:03 INFO - TEST-OK | dromaeo_css | took 1110882ms 22:23:03 INFO - TEST-START | kraken 22:23:03 INFO - operating with platform_type : linux_ 22:23:03 INFO - Initialising browser for kraken test... 22:23:03 INFO - TEST-INFO | started process 12180 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpas79mV/profile http://localhost:51974/getInfo.html) 22:23:06 INFO - PROCESS | 12180 | __metrics Screen width/height:1600/1200 22:23:06 INFO - PROCESS | 12180 | colorDepth:24 22:23:06 INFO - PROCESS | 12180 | Browser inner width/height: 1024/697 22:23:06 INFO - PROCESS | 12180 | __metrics 22:23:07 ERROR - PROCESS | 12180 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:23:08 INFO - TEST-INFO | 12180: exit 0 22:23:08 INFO - Browser initialized. 22:23:08 INFO - Running cycle 1/1 for kraken test... 22:23:08 INFO - TEST-INFO | started process 12263 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpas79mV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:20 INFO - PROCESS | 12263 | RSS: Main: 152707072 22:23:20 INFO - PROCESS | 12263 | 22:23:22 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51974/tests/kraken/driver.html?testName=audio-beat-detection) 22:23:23 INFO - PROCESS | 12263 | RSS: Main: 194162688 22:23:23 INFO - PROCESS | 12263 | 22:23:26 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51974/tests/kraken/driver.html?testName=audio-dft) 22:23:26 INFO - PROCESS | 12263 | RSS: Main: 182857728 22:23:26 INFO - PROCESS | 12263 | 22:23:29 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51974/tests/kraken/driver.html?testName=audio-fft) 22:23:30 INFO - PROCESS | 12263 | RSS: Main: 166871040 22:23:30 INFO - PROCESS | 12263 | 22:23:32 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51974/tests/kraken/driver.html?testName=audio-oscillator) 22:23:32 INFO - PROCESS | 12263 | RSS: Main: 169824256 22:23:32 INFO - PROCESS | 12263 | 22:23:34 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:23:35 INFO - PROCESS | 12263 | RSS: Main: 171544576 22:23:35 INFO - PROCESS | 12263 | 22:23:38 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51974/tests/kraken/driver.html?testName=imaging-darkroom) 22:23:39 INFO - PROCESS | 12263 | RSS: Main: 172396544 22:23:39 INFO - PROCESS | 12263 | 22:23:42 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51974/tests/kraken/driver.html?testName=imaging-desaturate) 22:23:43 INFO - PROCESS | 12263 | RSS: Main: 172179456 22:23:43 INFO - PROCESS | 12263 | 22:23:45 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51974/tests/kraken/driver.html?testName=json-parse-financial) 22:23:46 INFO - PROCESS | 12263 | RSS: Main: 173535232 22:23:46 INFO - PROCESS | 12263 | 22:23:47 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:23:48 INFO - PROCESS | 12263 | RSS: Main: 181825536 22:23:48 INFO - PROCESS | 12263 | 22:23:50 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:23:50 INFO - PROCESS | 12263 | RSS: Main: 179605504 22:23:50 INFO - PROCESS | 12263 | 22:23:52 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:23:53 INFO - PROCESS | 12263 | RSS: Main: 190398464 22:23:53 INFO - PROCESS | 12263 | 22:23:55 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:23:56 INFO - PROCESS | 12263 | RSS: Main: 200077312 22:23:56 INFO - PROCESS | 12263 | 22:23:58 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:23:59 INFO - PROCESS | 12263 | RSS: Main: 200114176 22:23:59 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | Cycle 1(1): loaded http://localhost:51974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51974/tests/kraken/driver.html?testName=ai-astar) 22:24:01 INFO - PROCESS | 12263 | RSS: Main: 261074944 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | __start_tp_report 22:24:01 INFO - PROCESS | 12263 | _x_x_mozilla_page_load 22:24:01 INFO - PROCESS | 12263 | _x_x_mozilla_page_load_details 22:24:01 INFO - PROCESS | 12263 | |i|pagename|runs| 22:24:01 INFO - PROCESS | 12263 | |0;ai-astar;109;110;105;110;110;111;99;109;110;110 22:24:01 INFO - PROCESS | 12263 | |1;audio-beat-detection;152;127;156;185;131;151;160;126;172;127 22:24:01 INFO - PROCESS | 12263 | |2;audio-dft;160;159;161;161;163;160;161;165;161;162 22:24:01 INFO - PROCESS | 12263 | |3;audio-fft;77;74;114;98;73;77;73;122;95;76 22:24:01 INFO - PROCESS | 12263 | |4;audio-oscillator;94;93;144;93;93;95;147;93;93;139 22:24:01 INFO - PROCESS | 12263 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;116;116;117 22:24:01 INFO - PROCESS | 12263 | |6;imaging-darkroom;144;146;145;145;147;146;146;145;145;146 22:24:01 INFO - PROCESS | 12263 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 22:24:01 INFO - PROCESS | 12263 | |8;json-parse-financial;57;58;58;57;58;58;60;67;55;55 22:24:01 INFO - PROCESS | 12263 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;62;61;61 22:24:01 INFO - PROCESS | 12263 | |10;stanford-crypto-aes;80;79;81;80;81;78;79;79;80;80 22:24:01 INFO - PROCESS | 12263 | |11;stanford-crypto-ccm;113;114;111;113;121;129;113;112;111;114 22:24:01 INFO - PROCESS | 12263 | |12;stanford-crypto-pbkdf2;145;144;149;143;143;134;142;144;144;146 22:24:01 INFO - PROCESS | 12263 | |13;stanford-crypto-sha256-iterative;65;64;68;64;66;66;62;65;64;64 22:24:01 INFO - PROCESS | 12263 | __end_tp_report 22:24:01 INFO - PROCESS | 12263 | __start_cc_report 22:24:01 INFO - PROCESS | 12263 | _x_x_mozilla_cycle_collect,1070 22:24:01 INFO - PROCESS | 12263 | __end_cc_report 22:24:01 INFO - PROCESS | 12263 | __startTimestamp1459920241415__endTimestamp 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | ------- Summary: start ------- 22:24:01 INFO - PROCESS | 12263 | Number of tests: 14 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.65 (3.3%) stddev-sans-first:3.87 22:24:01 INFO - PROCESS | 12263 | Values: 109.0 110.0 105.0 110.0 110.0 111.0 99.0 109.0 110.0 110.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.00 stddev:20.62 (13.4%) stddev-sans-first:21.84 22:24:01 INFO - PROCESS | 12263 | Values: 152.0 127.0 156.0 185.0 131.0 151.0 160.0 126.0 172.0 127.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.74 22:24:01 INFO - PROCESS | 12263 | Values: 160.0 159.0 161.0 161.0 163.0 160.0 161.0 165.0 161.0 162.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#3] audio-fft Cycles:10 Average:87.90 Median:76.50 stddev:18.30 (23.9%) stddev-sans-first:18.98 22:24:01 INFO - PROCESS | 12263 | Values: 77.0 74.0 114.0 98.0 73.0 77.0 73.0 122.0 95.0 76.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.19 (26.0%) stddev-sans-first:25.09 22:24:01 INFO - PROCESS | 12263 | Values: 94.0 93.0 144.0 93.0 93.0 95.0 147.0 93.0 93.0 139.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:24:01 INFO - PROCESS | 12263 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 22:24:01 INFO - PROCESS | 12263 | Values: 144.0 146.0 145.0 145.0 147.0 146.0 146.0 145.0 145.0 146.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:24:01 INFO - PROCESS | 12263 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:3.40 (5.9%) stddev-sans-first:3.57 22:24:01 INFO - PROCESS | 12263 | Values: 57.0 58.0 58.0 57.0 58.0 58.0 60.0 67.0 55.0 55.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 22:24:01 INFO - PROCESS | 12263 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 22:24:01 INFO - PROCESS | 12263 | Values: 80.0 79.0 81.0 80.0 81.0 78.0 79.0 79.0 80.0 80.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:113.50 stddev:5.65 (5.0%) stddev-sans-first:5.94 22:24:01 INFO - PROCESS | 12263 | Values: 113.0 114.0 111.0 113.0 121.0 129.0 113.0 112.0 111.0 114.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:144.00 stddev:3.84 (2.7%) stddev-sans-first:4.02 22:24:01 INFO - PROCESS | 12263 | Values: 145.0 144.0 149.0 143.0 143.0 134.0 142.0 144.0 144.0 146.0 22:24:01 INFO - PROCESS | 12263 | 22:24:01 INFO - PROCESS | 12263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 22:24:01 INFO - PROCESS | 12263 | Values: 65.0 64.0 68.0 64.0 66.0 66.0 62.0 65.0 64.0 64.0 22:24:01 INFO - PROCESS | 12263 | -------- Summary: end -------- 22:24:01 INFO - PROCESS | 12263 | 22:24:02 INFO - TEST-INFO | 12263: exit 0 22:24:02 INFO - TEST-OK | kraken | took 58711ms 22:24:02 INFO - SUITE-END | took 1169s 22:24:02 INFO - Completed test suite (00:19:29) 22:24:02 INFO - javascript benchmark 22:24:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3046.49732794089, 3080.3377273886126, 3081.245094951737, 3106.7048630380114, 3108.891188808392, 4990.75046247688, 5224.29472021277, 5234.7120908350025, 5242.292290540776, 5329.467053294668, 5269.104252277112, 5360.517553420192, 5373.301470808799, 5382.3541175059045, 5383.273258110154, 4777.259524773665, 4791.976040119795, 4814.109389762905, 4848.466668666444, 4960.727160006199, 4886.096072226649, 4909.7790599423115, 4939.50604939505, 4954.87612809679, 4982.128127577677, 4803.975980120112, 4829.251466022754, 4895.0209958008545, 4916.213405855082, 4920.089783390066, 4731.716097034189, 4734.786934587952, 4749.691270067435, 4795.568398844086, 4828.806847726087, 4727.787249573743, 4728.787204575802, 4741.905161896742, 4750.073735621555, 4772.952270477285, 5132.3327967364, 5145.33110695611, 5146.716930568818, 5235.764390602432, 5241.737913104368, 5671.120976248688, 5718.971405142947, 5719.885602287931, 5720.256366672347, 5726.284214473191, 5741.397153298927, 5765.0, 5767.192593036978, 5782.913256301159, 5784.045632470637, 5119.564836988823, 5351.438098999627, 5396.83809485716, 5422.620416570841, 5445.945540544623, 5701.4013528579735, 5704.3154821421695, 5705.857353566194, 5705.942940570624, 5723.141528770718, 5550.361708403505, 5551.0, 5552.0, 5556.222128901957, 5605.355384130796, 5498.697571633518, 5607.635503692247, 5673.063944449203, 5705.343885453143, 5720.456556627114, 5636.859078522988, 5640.153976903497, 5664.518515926193, 5675.460831221028, 5678.801241956512, 5450.8909821803345, 5635.8591035224445, 5656.434356564393, 5690.4025077367105, 5704.172894930211, 4225.661947044229, 4264.04059086703, 4267.381229721673, 4279.914401712011, 4297.82808687649, 3847.442120892511, 3862.5944275851193, 3874.6319099685484, 3896.2402331545645, 3905.1018265798457, 5285.762140703678, 5390.9191362129595, 5391.137418013099, 5398.24424580559, 5401.378841433207, 5713.285839270091, 5740.68426236561, 5761.711914404263, 5798.420157984252, 5812.767489300465, 5321.068812957717, 5323.1749078892835, 5324.813631522956, 5329.280547126166, 5338.145896656516, 4768.594669453136, 4863.781129849165, 4865.0756356292195, 4901.485344038824, 4929.186684197068, 5809.24479817621, 5823.82528524145, 5825.0679891217205, 5828.329742079631, 5874.206982057368, 5610.971945140248, 5626.915596266142, 5634.774609015593, 5636.126400407943, 5649.632773869767, 5694.259746232963, 5783.913241301468, 5784.623999440023, 5821.388754180919, 5864.266966629171, 5633.436656334334, 5638.379778224474, 5639.3232812062815, 5646.632968857011, 5660.179274005329, 5685.744141513559, 5692.686902220417, 5722.141678748221, 5726.685032323262, 5727.1695604138, 5342.78628854857, 5485.4788795064405, 5552.750126244409, 5612.438756124355, 5626.690532020778, 5559.833205003856, 5582.274304340573, 5589.357223919139, 5593.105103183471, 5594.1608758686525, 5495.5878309127775, 5518.530924871431, 5519.448055194448, 5522.641028333145, 5574.275344205227, 5441.428649991693, 5470.288862447856, 5518.42056584069, 5555.694436805853, 5628.60599758013, 5412.675239485643, 5433.049216387038, 5475.917861232165, 5498.092814685532, 5500.339959204921], "unit": "score", "name": "dojo.html", "value": 5223.612794523819}, {"lowerIsBetter": false, "replicates": [540.2196228433136, 556.7745063249386, 568.0286709726367, 580.8199458167966, 586.7037146241148, 29230.269243268904, 29624.999999999945, 29662.999999999975, 29693.257668558268, 36928.630713692924, 39880.80059599698, 40524.39213411794, 40572.0, 40628.59371406285, 40685.389719154235, 8577.142285771404, 8773.122687731207, 8781.824363512726, 8783.912160878404, 8788.16512431318, 8559.358048146414, 8621.698240561582, 8690.695825646104, 8716.912830871705, 8721.738347849574, 8545.829083418328, 8636.352273579476, 8674.392792504526, 8702.086280940504, 8944.821103577924, 8826.42628229163, 8884.644614215424, 8887.0, 8900.910990890074, 8901.154390332907, 8777.473351598861, 8876.778080547974, 8893.421927574687, 8900.51047192404, 8901.777455563599, 40640.39039414411, 41253.79373103145, 41293.58706412927, 41298.0, 41299.38050929239, 3428.63999280077, 3540.2565461253166, 3620.8732694355836, 3824.4836947012354, 4169.082801783603, 31608.525872111706, 31912.521312180335, 32181.356372872644, 32196.678033219836, 33080.669193308, 3920.823562939646, 3930.2728995135703, 3956.4065390191413, 4102.179564087194, 4229.006183546864, 290704.0, 292363.0, 292703.0, 293632.0, 294788.5260573705, 52860.20709689358, 58760.41239587549, 59035.0, 59075.40924590785, 60279.397206028254, 54932.725336373864, 55235.0, 55352.0, 55356.44643553513, 55368.0, 16009.679806403807, 16399.344026239054, 16436.6712665746, 16451.095189764677, 16457.09485978283, 11865.822012669816, 12568.120231583702, 12626.747465050832, 12689.302088385042, 12816.551420700418, 18969.146388412555, 19071.52321191981, 19180.520486987938, 19197.712034319495, 19228.519287017658, 7001.929980700128, 7003.649817509104, 7074.823129421703, 7100.3254690805325, 7105.502614817016, 1043.160255993917, 1091.2633972068822, 1121.775644871029, 1131.99838570654, 1136.7499150186945, 30521.0, 31381.37237255242, 31524.527132093037, 31731.841340793148, 31994.360112797614, 1091.6943255888364, 1196.8623608284984, 1201.5253974679952, 1231.347385885482, 1301.7461594988886, 16141.112238826978, 16438.83561164373, 16467.58831029234, 16489.6702065958, 16578.917105414635, 380367.0, 384892.0, 385494.0, 386018.0, 386242.0, 55190.0, 55442.16836747452, 55461.44538554644, 55543.44456555464, 55554.16668749972, 1301.8828305452555, 1329.2489743295007, 1349.0286993364762, 1384.1279993604167, 1394.28194479845, 27485.450290994468, 28398.85800570984, 29019.0, 29179.0, 29505.409891801613, 38405.23189536249, 38647.26087326133, 38795.2240955185, 39335.803320983214, 39339.409908850816, 193669.0, 194858.0, 195441.0, 195850.0, 196744.0, 33853.49219761755, 34508.13729656678, 34992.30015399627, 35006.47490287699, 35009.29981400409, 43743.25026998884, 44178.55821441873, 44386.778066109466, 44471.777641111585, 45369.09261814811, 37343.2531349366, 37679.0, 37803.35376523617, 37889.0, 38137.237255254186, 37201.81399092987, 37724.24551509009, 37851.810740946115, 37908.24183516259, 38069.619303806605, 37105.0, 37331.253374932894, 37944.0, 37953.05117372088, 38112.04719882025, 31691.52462713015, 32828.67171328256, 33475.83262083674, 33609.0, 33921.0, 25488.872555637103, 26466.86766566155, 26503.60244596294, 26581.60127598049, 26593.601095983187], "unit": "score", "name": "ext.html", "value": 18685.141887358048}, {"lowerIsBetter": false, "replicates": [358.8887444892083, 363.6254657702567, 366.95413073365825, 367.2159938531235, 368.0944875606009, 17137.742933856003, 17254.0, 18141.365052223176, 18194.0, 18221.544461388472, 17142.742858857127, 17509.562260943483, 17515.12424378779, 17520.82479175208, 17544.298228070893, 5056.797728090872, 5503.642263252896, 5504.422035686255, 5507.03626865299, 5507.118860982244, 3947.0, 4051.331530297512, 4052.5947405259385, 4055.5944405559503, 5407.3781515125875, 5786.652800831943, 5976.940230597704, 6002.699865006754, 6007.579469437119, 6020.367861374536, 5781.682007489587, 5980.970095149518, 6138.662373569452, 6148.538859585504, 6150.692465376758, 3646.161382881952, 5453.045716999509, 5458.2904222451225, 5463.590230732671, 5483.972580137074, 18979.62040759191, 19559.217631294872, 19682.80317196824, 19763.802361976483, 20520.0, 2253.4816992091746, 2343.988280058606, 2344.800691941187, 2498.5781052943976, 3022.8966427254113, 13089.672758181026, 13545.932270338684, 13667.794983075262, 13669.589912302647, 13717.314134293245, 1919.712043193532, 1955.4231501706888, 1970.0346830053313, 1975.8638782699861, 2004.8696834705697, 68047.65976170138, 68681.31318686799, 68897.65551172211, 69583.30416695819, 70937.0, 9091.27269818413, 9343.159115679622, 9547.713568592953, 9570.980188320922, 9669.70990870275, 12603.306818124907, 12609.495620175274, 12669.93665031669, 12687.429065692066, 12770.297633630054, 7635.389168866477, 7636.69453221876, 7953.204679532, 7988.241117093867, 8054.879176812353, 7885.250901164381, 7942.444028918036, 7964.20357964199, 8060.596970151469, 8084.878726819103, 5847.795327163614, 5849.970750146307, 5939.673317967553, 6020.096985452217, 6037.400088976425, 1635.5747505648617, 1692.8053273873415, 1725.6203635200236, 1730.5846596816925, 1760.5774614092782, 955.6607404371348, 1045.7019749371393, 1071.8928107189374, 1170.2627344772739, 1171.297221666993, 17124.914375428045, 17527.824721752873, 18038.007909564836, 18230.179641916147, 18280.725789113174, 1017.9694609161737, 1040.6773900090845, 1077.8975997280402, 1102.2119184782919, 1128.729105014807, 10597.523111460003, 10736.30214036085, 10753.0, 10763.623273185402, 10777.407242601575, 474573.0, 484638.0, 485703.0, 488608.0, 492284.0, 67962.0, 70505.0, 70817.0, 70919.0, 70993.0, 1093.10365500289, 1094.370736826328, 1098.5111625326813, 1107.595727559451, 1108.7449886526144, 16403.91798041002, 16408.26162822652, 16409.343626254817, 16417.835821642107, 16629.75055374146, 32557.674423255463, 32798.18004549905, 32972.835135825124, 33195.336093278485, 33481.0, 42514.362960459715, 44033.339499906884, 44122.33816492691, 44143.779281104675, 44186.55813441953, 7588.0, 7691.269329413921, 7769.339606133542, 7776.922230777846, 7794.454388192772, 12379.69050773738, 12544.996400288137, 12625.179363341353, 12690.428930697955, 12795.232286062866, 10643.095336896451, 10745.0, 10934.398608076313, 11165.162612804235, 11321.320720756781, 10258.12805911476, 10893.346399216072, 10947.178961577754, 10999.34003959765, 11233.550657973916, 10796.946015269874, 10811.189160812813, 11044.779104418027, 11348.943255284, 11465.656030319104, 7663.616819158909, 7761.301482866569, 7786.7663970080985, 7912.723054693058, 7937.523748575104, 10631.521581529005, 11261.268017578832, 11330.60342887995, 11634.36011019402, 11657.125715571197], "unit": "score", "name": "jquery.html", "value": 8731.456487069598}, {"lowerIsBetter": false, "replicates": [1475.6089636246393, 1502.0462006625792, 1678.2951160512584, 1798.4424828303236, 1819.1722766141415, 7812.843743125134, 8089.676412943475, 8090.474119182249, 8096.028476582811, 8097.0, 6979.441644668427, 7590.392768578514, 7814.296713295802, 7834.569098699583, 8069.03171619405, 2272.034385386208, 2307.8153747700144, 2308.1113771198125, 2309.2725791375665, 2311.4221444638843, 2002.7496562929634, 2311.641695537194, 2311.7919387255142, 2359.681443005198, 2366.9408264793346, 2249.3364457485, 2297.7587353327913, 2302.458922153293, 2303.0787684925995, 2308.411355104446, 2260.2541161416693, 2272.625016872214, 2332.6267797152545, 2335.2877372401413, 2338.123203798584, 2237.7314722233436, 2248.2580748353002, 2261.479859632277, 2292.713410823647, 2292.747797742247, 7911.564863932482, 7960.880586791202, 7962.920370796276, 8084.312833409167, 8106.310963568104, 5036.622253331015, 5109.897802043938, 5122.590192784568, 5157.510036546522, 5167.354080739908, 3355.144438168276, 3439.8624055037767, 3460.567429071366, 3478.9389236282923, 3512.701420379271, 1122.6183097746805, 1176.1237877781107, 1181.551010615969, 1215.6231568213793, 1224.381687247943, 11207.775844483065, 11229.3262404256, 11234.49444774987, 11238.325700457917, 11252.043576296024, 4503.954960450354, 4545.38637283969, 4616.238320677118, 4626.0979109073405, 4633.374494443275, 9556.283278754121, 9565.234781217487, 9566.56950437232, 9570.856437153448, 9583.329166958385, 5137.563307118862, 5146.099432599281, 5169.276301317818, 5186.5850731941355, 5191.9480805192225, 4759.119562880878, 4767.141914455362, 4767.4517430495935, 4772.093302272557, 4774.045190961821, 3751.1372384351753, 3890.922181556353, 3912.550056743511, 3919.8432062717743, 3930.1746633206776, 1146.9770604587861, 1248.1637303007008, 1253.2042153232762, 1269.4033804112053, 1276.942537585811, 1127.1771606727134, 1153.6942710181809, 1167.258790667932, 1172.8827117288204, 1178.452019810792, 7590.3927685785, 7654.4259180561685, 7685.269899359552, 7714.0, 7733.690652373954, 1077.2459278505078, 1090.574675876409, 1121.685927940178, 1138.4023387721513, 1171.9531218751154, 6139.2325959255095, 6148.938510614926, 6188.938110618837, 6196.47329976948, 6200.782972595937, 9198.356115071882, 9977.650782222587, 9984.80030399388, 10119.0, 10124.240681948882, 9829.508524573886, 9881.703548893545, 9952.900470995197, 9978.550965206583, 9991.550380232908, 7441.925580744123, 7890.842183156305, 7901.209879012168, 7902.486338388101, 7906.05127384706, 7331.926680733338, 7387.741429049957, 7397.963010184914, 7414.777556673308, 7420.332170104716, 8592.140785921358, 8793.384463087523, 8901.421407608485, 8910.287177025693, 9060.093990600888, 8774.385792994684, 8833.646654133763, 9018.188363047357, 9019.77450563715, 9031.638734450811, 7297.379722723628, 7348.1182258129365, 7396.778096657109, 7399.852002960019, 7401.481896267425, 7469.290417410337, 7622.466427350032, 7870.055593328837, 7920.920790792249, 7932.04815422153, 7094.53885497441, 7138.678759455941, 7140.7857764267155, 7234.74678386254, 7235.095613048369, 5955.553333499918, 6933.4106600939485, 6986.161660600557, 7040.507164498641, 7063.470239731938, 7421.517601355895, 7493.025906632103, 7494.100707915085, 7498.58757768328, 7521.473496855387, 6845.315468453115, 6947.826304342432, 6968.547044442095, 6970.407515361251, 6973.895391569232, 6977.616231107338, 6986.301369862973, 6999.195092564217, 7018.613976231152, 7033.824154396181], "unit": "score", "name": "mootools.html", "value": 4714.058150111972}, {"lowerIsBetter": false, "replicates": [335.7079340973353, 336.8635702540472, 338.7154789976419, 341.4809489575845, 347.94606835940425, 6057.697115144236, 6061.7575296988125, 6077.848053798657, 6083.817485475437, 6120.969395153018, 6047.818565443033, 6072.54455915807, 6074.939250607493, 6077.11881777142, 6084.330723620398, 4452.777361131946, 4557.9772101139615, 4625.213713668668, 4660.370849935266, 4681.953180468203, 4686.109639168564, 4690.484046754854, 4696.553827386393, 4696.906061878761, 4705.106029854317, 4652.604528615072, 4653.418322709661, 4658.440987081538, 4667.603253723438, 4670.065986802636, 4444.799984000711, 4507.819687212491, 4544.136614043321, 4557.931631025537, 4558.9772051139535, 4004.1391100913443, 4021.195760847842, 4026.7583944963103, 4027.0, 4032.213718324928, 5688.402717714663, 5735.082386818089, 5760.279965004374, 5762.366139724627, 5766.0, 5347.759350829183, 5351.7056561889085, 5354.223637572569, 5356.6518176318805, 5361.758720857571, 6311.116443697886, 6313.526485513559, 6314.747410103636, 6322.367763223687, 6323.462505687022, 4244.787760611957, 4382.211201983641, 4382.255016647177, 4386.627136693385, 4495.685302028859, 6567.868642627121, 6568.507361947873, 6586.967065164691, 6618.503612229102, 6630.900536491957, 4439.045605194834, 4487.798049087799, 4489.0, 4491.483479399845, 4497.415336006298, 4540.364348991144, 4546.863594092182, 4547.681662283675, 4557.088582283556, 4557.612602928788, 5278.894422111536, 5286.07493688603, 5289.70906600133, 5293.973530132324, 5295.311609490818, 6277.843053923597, 6451.29035806061, 6467.223933128054, 6480.351964803576, 6500.187476565429, 1582.8654564361927, 1594.067470529753, 1595.13862514241, 1600.3758534171682, 1604.4865642994364, 993.7465946183677, 1000.3047881722133, 1030.294248439821, 1048.6591857646295, 1051.7265510967204, 6084.726187321493, 6128.080787881764, 6128.356522565066, 6234.0, 6276.340984196685, 6678.899816502756, 6688.431483323875, 6691.096701945273, 6697.7655782047395, 6703.966480167665, 6240.157578726905, 6253.593516421418, 6254.499640028786, 6264.436200741864, 6266.780662676875, 3558.644135586472, 3595.0293420776243, 3597.5323207982797, 3602.3875941089555, 3604.2611264690677, 6574.211094668671, 6624.701888414937, 6640.335966403321, 6642.800715978528, 6818.624975626289, 6493.577917435352, 6613.669316534154, 6643.833904152435, 6653.168353955755, 6703.12859328294, 6645.640797517005, 6702.463802895757, 6872.0, 6884.51808373409, 6891.793246202722, 6643.368879956396, 6649.900251496329, 6649.966750166218, 6655.866882662222, 6668.733250669919, 6574.11249481333, 6576.506761992965, 6581.539292249497, 6584.76953306632, 6597.637129957899, 6908.1019467468905, 6910.7581234656545, 6918.481113916577, 6925.27284635106, 6925.89611155823, 4459.085887393141, 4493.865184044484, 4496.505384407647, 4499.302608095751, 4502.3471596618965, 6353.491720662429, 6361.936380636134, 6456.709448074942, 6461.418472337512, 6631.303713110054, 6441.645709486023, 6453.257875344396, 6453.935460645521, 6461.773837915838, 6475.902861457176, 6437.645929473924, 6441.903371449338, 6443.387878151568, 6445.581037232565, 6448.806535803933, 6329.715162817776, 6331.620102793847, 6349.904751428639, 6357.0, 6364.268109167505, 6315.96842015787, 6475.255345635313, 6480.351964803482, 6492.610443373413, 6494.870102597827, 6275.152854364603, 6318.147050148171, 6324.873502530016, 6337.271213810286, 6346.524010699309], "unit": "score", "name": "prototype.html", "value": 4818.88737461376}, {"lowerIsBetter": false, "replicates": [732.2165283147035, 786.7954331873715, 798.034378402133, 808.656321063548, 851.4891065360785, 14191.787123193148, 14431.350589223484, 14439.06146100504, 14470.421183152674, 14578.271086445688, 12621.62135135945, 13482.056256062055, 13885.791713124312, 13911.443542258323, 13914.30428478577, 793.5595744361891, 801.0667572278289, 802.9718959836407, 807.1444269074799, 808.1756608259572, 783.8001309666056, 784.4077721320396, 785.2657764989724, 785.7721260834351, 786.830831371255, 855.589317127779, 856.178069053706, 856.3962406503431, 857.5497863621587, 857.7684025313193, 850.740524140137, 850.961706723199, 853.5604163855619, 853.632937836733, 854.0093491549803, 618.5700937848197, 619.3806193806194, 619.9132121502993, 620.6555361774259, 621.3382747374033, 11817.468213930308, 11857.0, 11886.108541859308, 11899.405029748477, 12010.69973250667, 11307.321560706301, 11367.658970230907, 11488.253263537843, 11509.769804603944, 11715.765684686345, 10718.785624287471, 12479.31363775001, 12553.121281510297, 12611.810822837664, 12694.746105077938, 4492.460904691426, 4535.365048893158, 4630.513796051399, 4634.142683603511, 4727.598154156901, 47677.523224767654, 48191.03617927657, 48588.51411485875, 48714.26928596074, 49042.0, 10773.569057237779, 10850.29473084247, 10865.83701244482, 10914.672559823059, 11006.284591501688, 18705.81294187041, 18706.625867482573, 18727.81272187288, 18731.25074997012, 18977.43067707971, 8176.672933082729, 8200.83598328042, 8204.83590328202, 8383.077861435237, 8488.278496327757, 4831.371921650233, 4843.0, 4858.902821943541, 4906.092372911023, 5121.2574176744165, 3305.190228394059, 3327.2680010397676, 3328.1679580104974, 3330.2673411849355, 3350.0452371074125, 593.902006168986, 598.1536126381209, 610.5420934299276, 613.8373331067271, 621.1521273461783, 736.988945165823, 740.0859937976595, 743.8028922335585, 753.6985205917676, 768.673313841615, 8748.91251087481, 9227.645108949951, 9307.348485605942, 9491.430514169035, 9733.318667693335, 561.2871653000666, 647.2104033079635, 676.3338111959715, 715.992840071603, 724.9565026098451, 4067.2068946555137, 4241.1941731071, 4516.187086324493, 4529.501754806968, 4598.494165641777, 57207.0, 58511.0, 58900.0, 59170.704146478995, 59221.0, 43413.34879976803, 50954.490455095714, 51395.229071563954, 54471.0, 54901.0, 47996.760016200395, 48120.27819582709, 48204.5179548207, 48263.27605085926, 49131.263031054565, 9933.950330248303, 10078.244131690299, 10084.394936303845, 10146.53905722578, 10174.491275436347, 36598.26803463969, 36823.815880920425, 37648.623513765604, 37783.0, 38225.61774382221, 45056.549434505236, 45818.541814581426, 45877.0, 46573.767131164124, 46847.76576117097, 12138.150329477205, 12215.755684886075, 12263.26420414778, 12374.81437778416, 12394.0, 13540.241137160543, 13724.862751372759, 13958.930205348908, 14083.155010699391, 14171.362288696828, 12960.935195323964, 13052.412641430969, 13062.150960187937, 13067.607971760863, 13144.40850161726, 12449.564265251034, 12626.936865315982, 12642.115051946275, 12849.164804287691, 12974.870251297367, 12833.358332083546, 13207.471701131846, 13410.32948352559, 13715.382807773474, 13749.931250343685, 10711.357318560911, 10865.674029779118, 10973.835392469278, 11064.502097405475, 11114.833277500682, 10571.36571805694, 10634.84047739269, 10678.946605266923, 10697.679069627924, 10784.759752628235], "unit": "score", "name": "yui.html", "value": 6727.077266118235}], "name": "dromaeo_css", "value": 7119.669836081574}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 110.0, 111.0, 99.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 156.0, 185.0, 131.0, 151.0, 160.0, 126.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.7}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 161.0, 163.0, 160.0, 161.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 114.0, 98.0, 73.0, 77.0, 73.0, 122.0, 95.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 144.0, 93.0, 93.0, 95.0, 147.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 60.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.0}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 81.0, 80.0, 81.0, 78.0, 79.0, 79.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 111.0, 113.0, 121.0, 129.0, 113.0, 112.0, 111.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.1}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 149.0, 143.0, 143.0, 134.0, 142.0, 144.0, 144.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 68.0, 64.0, 66.0, 66.0, 62.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1494.1000000000001}]} 22:24:02 INFO - Return code: 0 22:24:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:24:02 ERROR - # TBPL SUCCESS # 22:24:02 INFO - Running post-action listener: _resource_record_post_action 22:24:02 INFO - Running post-run listener: _resource_record_post_run 22:24:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393646080; Read time: 180; Write time: 312364 22:24:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108617728; Read time: 24; Write time: 108804 22:24:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285028352; Read time: 156; Write time: 203560 22:24:03 INFO - Running post-run listener: _upload_blobber_files 22:24:03 INFO - Blob upload gear active. 22:24:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:24:03 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 22:24:03 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'] 22:24:03 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 22:24:04 INFO - (blobuploader) - INFO - Open directory for files ... 22:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:04 INFO - (blobuploader) - INFO - Done attempting. 22:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:24:05 INFO - (blobuploader) - INFO - Done attempting. 22:24:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:24:05 INFO - Return code: 0 22:24:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:24:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:24:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93472939b98e234866afb2d47b4cda9c2b63db2c9956813e6366a83c130bcde81c4142685ff24358bfcafea2fc83b4226b0027d50e762af3bf6051d6bc044f08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b09f2ace83bbfdb086e7ecacdb732d740ed7a7858693dcebfa3218e34c980b80d1d09aca46ab38ef3829451498c1eeff461d143603c209cd9f82a335a6f6cad"} 22:24:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:24:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:24:05 INFO - Contents: 22:24:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93472939b98e234866afb2d47b4cda9c2b63db2c9956813e6366a83c130bcde81c4142685ff24358bfcafea2fc83b4226b0027d50e762af3bf6051d6bc044f08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b09f2ace83bbfdb086e7ecacdb732d740ed7a7858693dcebfa3218e34c980b80d1d09aca46ab38ef3829451498c1eeff461d143603c209cd9f82a335a6f6cad"} 22:24:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:24:05 INFO - Copying logs to upload dir... 22:24:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:24:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.923497 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-05 22:24:05.074179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:05.078047) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 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/93472939b98e234866afb2d47b4cda9c2b63db2c9956813e6366a83c130bcde81c4142685ff24358bfcafea2fc83b4226b0027d50e762af3bf6051d6bc044f08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b09f2ace83bbfdb086e7ecacdb732d740ed7a7858693dcebfa3218e34c980b80d1d09aca46ab38ef3829451498c1eeff461d143603c209cd9f82a335a6f6cad"} build_url:https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/MYtnLmFkSOqAGBY3aFAOrA/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/93472939b98e234866afb2d47b4cda9c2b63db2c9956813e6366a83c130bcde81c4142685ff24358bfcafea2fc83b4226b0027d50e762af3bf6051d6bc044f08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5b09f2ace83bbfdb086e7ecacdb732d740ed7a7858693dcebfa3218e34c980b80d1d09aca46ab38ef3829451498c1eeff461d143603c209cd9f82a335a6f6cad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:05.103131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:05.103448) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459918084.487388-957404744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 22:24:05.186446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:24:05.186765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 22:24:05.187041) ========= ========= Total master_lag: 0.56 =========