builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1457646119.06 results: success (0) buildid: 20160310105922 builduid: 9875f09f2cea44ca8960bc6d026ac797 revision: abdbe1190ce3b25fabe31899864e57cd6fff6623 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.055996) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.056581) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.056908) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005549 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.098514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.098840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.156124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.156443) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025346 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.206360) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.206664) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.207058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.207371) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-10 13:41:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-03-10 13:41:59 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.460049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.685395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.685750) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.163049 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.861352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:41:59.861697) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev abdbe1190ce3b25fabe31899864e57cd6fff6623 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev abdbe1190ce3b25fabe31899864e57cd6fff6623 --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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-10 13:41:59,980 truncating revision to first 12 chars 2016-03-10 13:41:59,980 Setting DEBUG logging. 2016-03-10 13:41:59,980 attempt 1/10 2016-03-10 13:41:59,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/abdbe1190ce3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 13:42:00,218 unpacking tar archive at: mozilla-aurora-abdbe1190ce3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 13:42:00.402555) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 13:42:00.402903) ========= echo abdbe1190ce3b25fabe31899864e57cd6fff6623 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'abdbe1190ce3b25fabe31899864e57cd6fff6623'] 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False abdbe1190ce3b25fabe31899864e57cd6fff6623 program finished with exit code 0 elapsedTime=0.004551 script_repo_revision: 'abdbe1190ce3b25fabe31899864e57cd6fff6623' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 13:42:00.455286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 13:42:00.455635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 13:42:00.470158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-10 13:42:00.470464) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:42:00 INFO - MultiFileLogger online at 20160310 13:42:00 in /builds/slave/test-pgo 13:42:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:42:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:42:00 INFO - {'append_to_log': False, 13:42:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:42:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:42:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:42:00 INFO - 'branch': 'Mozilla-Aurora', 13:42:00 INFO - 'buildbot_json_path': 'buildprops.json', 13:42:00 INFO - 'config_files': ('talos/linux_config.py',), 13:42:00 INFO - 'default_actions': ('clobber', 13:42:00 INFO - 'read-buildbot-config', 13:42:00 INFO - 'download-and-extract', 13:42:00 INFO - 'populate-webroot', 13:42:00 INFO - 'create-virtualenv', 13:42:00 INFO - 'install', 13:42:00 INFO - 'run-tests'), 13:42:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:42:00 INFO - 'download_minidump_stackwalk': True, 13:42:00 INFO - 'download_symbols': 'ondemand', 13:42:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:42:00 INFO - 'tooltool.py': '/tools/tooltool.py', 13:42:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:42:00 INFO - '/tools/misc-python/virtualenv.py')}, 13:42:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:42:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:42:00 INFO - 'installer_path': 'installer.exe', 13:42:00 INFO - 'log_level': 'info', 13:42:00 INFO - 'log_name': 'talos', 13:42:00 INFO - 'log_to_console': True, 13:42:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:42:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:42:00 INFO - 'opt_config_files': (), 13:42:00 INFO - 'pip_index': False, 13:42:00 INFO - 'sps_profile': False, 13:42:00 INFO - 'sps_profile_interval': 0, 13:42:00 INFO - 'suite': 'dromaeojs', 13:42:00 INFO - 'system_bits': '32', 13:42:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:42:00 INFO - 'title': 'talos-linux64-ix-018', 13:42:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:42:00 INFO - 'use_talos_json': True, 13:42:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:42:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:42:00 INFO - 'work_dir': 'build'} 13:42:00 INFO - ##### 13:42:00 INFO - ##### Running clobber step. 13:42:00 INFO - ##### 13:42:00 INFO - Running pre-action listener: _resource_record_pre_action 13:42:00 INFO - Running main action method: clobber 13:42:00 INFO - rmtree: /builds/slave/test-pgo/build 13:42:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:42:01 INFO - Running post-action listener: _resource_record_post_action 13:42:01 INFO - ##### 13:42:01 INFO - ##### Running read-buildbot-config step. 13:42:01 INFO - ##### 13:42:01 INFO - Running pre-action listener: _resource_record_pre_action 13:42:01 INFO - Running main action method: read_buildbot_config 13:42:01 INFO - Using buildbot properties: 13:42:01 INFO - { 13:42:01 INFO - "project": "", 13:42:01 INFO - "product": "firefox", 13:42:01 INFO - "script_repo_revision": "production", 13:42:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:42:01 INFO - "repository": "", 13:42:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:42:01 INFO - "buildid": "20160310105922", 13:42:01 INFO - "pgo_build": "True", 13:42:01 INFO - "basedir": "/builds/slave/test-pgo", 13:42:01 INFO - "buildnumber": 221, 13:42:01 INFO - "slavename": "talos-linux64-ix-018", 13:42:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:42:01 INFO - "platform": "ubuntu64_hw", 13:42:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:42:01 INFO - "branch": "mozilla-aurora", 13:42:01 INFO - "repo_path": "releases/mozilla-aurora", 13:42:01 INFO - "revision": "abdbe1190ce3b25fabe31899864e57cd6fff6623", 13:42:01 INFO - "stage_platform": "linux64-pgo", 13:42:01 INFO - "builduid": "9875f09f2cea44ca8960bc6d026ac797", 13:42:01 INFO - "slavebuilddir": "test" 13:42:01 INFO - } 13:42:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 13:42:01 INFO - Running post-action listener: _resource_record_post_action 13:42:01 INFO - ##### 13:42:01 INFO - ##### Running download-and-extract step. 13:42:01 INFO - ##### 13:42:01 INFO - Running pre-action listener: _resource_record_pre_action 13:42:01 INFO - Running main action method: download_and_extract 13:42:02 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:02 INFO - https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:42:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:42:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:42:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:42:05 INFO - Downloaded 1448 bytes. 13:42:05 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 13:42:05 INFO - Using the following test package requirements: 13:42:05 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:42:05 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:42:05 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:42:05 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'jsshell-linux-x86_64.zip'], 13:42:05 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:42:05 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:42:05 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:42:05 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:42:05 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:42:05 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 13:42:05 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 13:42:05 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:42:05 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:05 INFO - https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:42:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:42:19 INFO - Downloaded 23305548 bytes. 13:42:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:42:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:42:20 INFO - Return code: 0 13:42:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:20 INFO - https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:42:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 13:42:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:42:22 INFO - Downloaded 23305548 bytes. 13:42:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:42:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:42:23 INFO - Return code: 0 13:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:23 INFO - https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 13:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:42:25 INFO - Downloaded 10845161 bytes. 13:42:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:42:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:42:25 INFO - Return code: 0 13:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:25 INFO - https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:42:26 INFO - retry: attempt #1 caught exception: '' 13:42:26 INFO - retry: Failed, sleeping 30 seconds before retrying 13:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 13:42:59 INFO - Downloaded 60417851 bytes. 13:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:42:59 INFO - mkdir: /builds/slave/test-pgo/properties 13:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:42:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:42:59 INFO - Contents: 13:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 13:42:59 INFO - Running post-action listener: _resource_record_post_action 13:42:59 INFO - Running post-action listener: set_extra_try_arguments 13:42:59 INFO - ##### 13:42:59 INFO - ##### Running populate-webroot step. 13:42:59 INFO - ##### 13:42:59 INFO - Running pre-action listener: _resource_record_pre_action 13:42:59 INFO - Running main action method: populate_webroot 13:42:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:42:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:42:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:42:59 INFO - '--tppagecycles', 13:42:59 INFO - '7'], 13:42:59 INFO - 'tests': ['tsvgm']}}, 13:42:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:42:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:42:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:42:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:42:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:59 INFO - 'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:59 INFO - 'tests': ['damp', 'tps']}, 13:42:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:59 INFO - 'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['damp', 'tps']}, 13:42:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:42:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:42:59 INFO - 'other': {'tests': ['a11yr', 13:42:59 INFO - 'ts_paint', 13:42:59 INFO - 'tpaint', 13:42:59 INFO - 'sessionrestore', 13:42:59 INFO - 'sessionrestore_no_auto_restore', 13:42:59 INFO - 'tabpaint']}, 13:42:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['a11yr', 13:42:59 INFO - 'ts_paint', 13:42:59 INFO - 'tpaint', 13:42:59 INFO - 'sessionrestore', 13:42:59 INFO - 'sessionrestore_no_auto_restore', 13:42:59 INFO - 'tabpaint']}, 13:42:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['a11yr', 13:42:59 INFO - 'ts_paint', 13:42:59 INFO - 'tpaint', 13:42:59 INFO - 'sessionrestore', 13:42:59 INFO - 'sessionrestore_no_auto_restore', 13:42:59 INFO - 'tabpaint']}, 13:42:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:42:59 INFO - 'tests': ['a11yr', 13:42:59 INFO - 'ts_paint', 13:42:59 INFO - 'tpaint', 13:42:59 INFO - 'sessionrestore', 13:42:59 INFO - 'sessionrestore_no_auto_restore', 13:42:59 INFO - 'tabpaint']}, 13:42:59 INFO - 'other_l64': {'tests': ['a11yr', 13:43:00 INFO - 'ts_paint', 13:43:00 INFO - 'tpaint', 13:43:00 INFO - 'sessionrestore', 13:43:00 INFO - 'sessionrestore_no_auto_restore', 13:43:00 INFO - 'tabpaint']}, 13:43:00 INFO - 'other_nol64': {'tests': ['a11yr', 13:43:00 INFO - 'ts_paint', 13:43:00 INFO - 'tpaint', 13:43:00 INFO - 'sessionrestore', 13:43:00 INFO - 'sessionrestore_no_auto_restore', 13:43:00 INFO - 'tabpaint']}, 13:43:00 INFO - 'svgr': {'tests': ['tsvgx', 13:43:00 INFO - 'tsvgr_opacity', 13:43:00 INFO - 'tart', 13:43:00 INFO - 'tscrollx', 13:43:00 INFO - 'cart']}, 13:43:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:43:00 INFO - 'tests': ['tsvgx', 13:43:00 INFO - 'tsvgr_opacity', 13:43:00 INFO - 'tart', 13:43:00 INFO - 'tscrollx', 13:43:00 INFO - 'cart']}, 13:43:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:00 INFO - 'tests': ['tp5o']}, 13:43:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:00 INFO - 'talos_options': ['--e10s'], 13:43:00 INFO - 'tests': ['tp5o']}, 13:43:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:00 INFO - 'talos_options': ['--xperf_path', 13:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:00 INFO - 'tests': ['tp5n']}, 13:43:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:00 INFO - 'talos_options': ['--e10s', 13:43:00 INFO - '--xperf_path', 13:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:00 INFO - 'tests': ['tp5n']}}, 13:43:00 INFO - 'talos.zip': {'path': '', 13:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:00 INFO - Running post-action listener: _resource_record_post_action 13:43:00 INFO - ##### 13:43:00 INFO - ##### Running create-virtualenv step. 13:43:00 INFO - ##### 13:43:00 INFO - Running pre-action listener: _resource_record_pre_action 13:43:00 INFO - Running main action method: create_virtualenv 13:43:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:43:00 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 13:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:00 INFO - Using real prefix '/usr' 13:43:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:43:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:02 INFO - Installing pip.................done. 13:43:02 INFO - Return code: 0 13:43:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:02 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:02 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 13:43:02 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 13:43:02 INFO - Using env: {'DISPLAY': ':0', 13:43:02 INFO - 'HOME': '/home/cltbld', 13:43:02 INFO - 'LANG': 'en_US.UTF-8', 13:43:02 INFO - 'LANGUAGE': 'en_US:en', 13:43:02 INFO - 'LOGNAME': 'cltbld', 13:43:02 INFO - 'MAIL': '/var/mail/cltbld', 13:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:02 INFO - 'MOZ_NO_REMOTE': '1', 13:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:02 INFO - 'NO_EM_RESTART': '1', 13:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:02 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:02 INFO - 'SHELL': '/bin/bash', 13:43:02 INFO - 'SHLVL': '1', 13:43:02 INFO - 'TERM': 'linux', 13:43:02 INFO - 'TMOUT': '86400', 13:43:02 INFO - 'USER': 'cltbld', 13:43:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:02 INFO - '_': '/tools/buildbot/bin/python'} 13:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:03 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 13:43:03 INFO - Cleaning up... 13:43:03 INFO - Return code: 0 13:43:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:43: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')]} 13:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:03 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:03 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 13:43:03 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 13:43:03 INFO - Using env: {'DISPLAY': ':0', 13:43:03 INFO - 'HOME': '/home/cltbld', 13:43:03 INFO - 'LANG': 'en_US.UTF-8', 13:43:03 INFO - 'LANGUAGE': 'en_US:en', 13:43:03 INFO - 'LOGNAME': 'cltbld', 13:43:03 INFO - 'MAIL': '/var/mail/cltbld', 13:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:03 INFO - 'MOZ_NO_REMOTE': '1', 13:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:03 INFO - 'NO_EM_RESTART': '1', 13:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:03 INFO - 'SHELL': '/bin/bash', 13:43:03 INFO - 'SHLVL': '1', 13:43:03 INFO - 'TERM': 'linux', 13:43:03 INFO - 'TMOUT': '86400', 13:43:03 INFO - 'USER': 'cltbld', 13:43:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:03 INFO - '_': '/tools/buildbot/bin/python'} 13:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:03 INFO - Downloading/unpacking psutil>=0.7.1 13:43:03 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 13:43:03 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 13:43:03 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 13:43:03 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 13:43:03 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 13:43:03 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 13:43:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:05 INFO - Installing collected packages: psutil 13:43:05 INFO - Running setup.py install for psutil 13:43:05 INFO - building 'psutil._psutil_linux' extension 13:43:05 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 13:43:06 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 13:43:06 INFO - building 'psutil._psutil_posix' extension 13:43:06 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 13:43:06 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 13:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:06 INFO - Successfully installed psutil 13:43:06 INFO - Cleaning up... 13:43:06 INFO - Return code: 0 13:43:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:06 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:06 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 13:43:06 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 13:43:06 INFO - Using env: {'DISPLAY': ':0', 13:43:06 INFO - 'HOME': '/home/cltbld', 13:43:06 INFO - 'LANG': 'en_US.UTF-8', 13:43:06 INFO - 'LANGUAGE': 'en_US:en', 13:43:06 INFO - 'LOGNAME': 'cltbld', 13:43:06 INFO - 'MAIL': '/var/mail/cltbld', 13:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:06 INFO - 'MOZ_NO_REMOTE': '1', 13:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:06 INFO - 'NO_EM_RESTART': '1', 13:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:06 INFO - 'SHELL': '/bin/bash', 13:43:06 INFO - 'SHLVL': '1', 13:43:06 INFO - 'TERM': 'linux', 13:43:06 INFO - 'TMOUT': '86400', 13:43:06 INFO - 'USER': 'cltbld', 13:43:06 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:06 INFO - '_': '/tools/buildbot/bin/python'} 13:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:43:06 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 13:43:06 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 13:43:06 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 13:43:06 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 13:43:06 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 13:43:06 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 13:43:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:43:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:43:08 INFO - Installing collected packages: mozsystemmonitor 13:43:08 INFO - Running setup.py install for mozsystemmonitor 13:43:08 INFO - Successfully installed mozsystemmonitor 13:43:08 INFO - Cleaning up... 13:43:08 INFO - Return code: 0 13:43:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:43: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')]} 13:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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', '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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:43: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 blobuploader==1.2.4 13:43:08 INFO - Using env: {'DISPLAY': ':0', 13:43:08 INFO - 'HOME': '/home/cltbld', 13:43:08 INFO - 'LANG': 'en_US.UTF-8', 13:43:08 INFO - 'LANGUAGE': 'en_US:en', 13:43:08 INFO - 'LOGNAME': 'cltbld', 13:43:08 INFO - 'MAIL': '/var/mail/cltbld', 13:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:08 INFO - 'MOZ_NO_REMOTE': '1', 13:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:08 INFO - 'NO_EM_RESTART': '1', 13:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:08 INFO - 'SHELL': '/bin/bash', 13:43:08 INFO - 'SHLVL': '1', 13:43:08 INFO - 'TERM': 'linux', 13:43:08 INFO - 'TMOUT': '86400', 13:43:08 INFO - 'USER': 'cltbld', 13:43:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:08 INFO - '_': '/tools/buildbot/bin/python'} 13:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 13:43:09 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 13:43:09 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 13:43:09 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 13:43:09 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 13:43:09 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 13:43:09 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 13:43:10 INFO - Downloading blobuploader-1.2.4.tar.gz 13:43:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:43:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:43:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:11 INFO - Downloading docopt-0.6.1.tar.gz 13:43:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:43:11 INFO - Installing collected packages: blobuploader, requests, docopt 13:43:11 INFO - Running setup.py install for blobuploader 13:43:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:43:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:43:11 INFO - Running setup.py install for requests 13:43:12 INFO - Running setup.py install for docopt 13:43:12 INFO - Successfully installed blobuploader requests docopt 13:43:12 INFO - Cleaning up... 13:43:12 INFO - Return code: 0 13:43:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:12 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:12 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 13:43:12 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 13:43:12 INFO - Using env: {'DISPLAY': ':0', 13:43:12 INFO - 'HOME': '/home/cltbld', 13:43:12 INFO - 'LANG': 'en_US.UTF-8', 13:43:12 INFO - 'LANGUAGE': 'en_US:en', 13:43:12 INFO - 'LOGNAME': 'cltbld', 13:43:12 INFO - 'MAIL': '/var/mail/cltbld', 13:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:12 INFO - 'MOZ_NO_REMOTE': '1', 13:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:12 INFO - 'NO_EM_RESTART': '1', 13:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:12 INFO - 'SHELL': '/bin/bash', 13:43:12 INFO - 'SHLVL': '1', 13:43:12 INFO - 'TERM': 'linux', 13:43:12 INFO - 'TMOUT': '86400', 13:43:12 INFO - 'USER': 'cltbld', 13:43:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:12 INFO - '_': '/tools/buildbot/bin/python'} 13:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:43:12 INFO - Running setup.py (path:/tmp/pip-DL6twU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:43:12 INFO - Running setup.py (path:/tmp/pip-b_83YK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:43:12 INFO - Running setup.py (path:/tmp/pip-kjROKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:43:12 INFO - Running setup.py (path:/tmp/pip-Itzqez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:43:12 INFO - Running setup.py (path:/tmp/pip-9dAJCs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:43:12 INFO - Running setup.py (path:/tmp/pip-mp_Icv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:43:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:43:12 INFO - Running setup.py (path:/tmp/pip-rk4lHA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:43:13 INFO - Running setup.py (path:/tmp/pip-w1QDTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:43:13 INFO - Running setup.py (path:/tmp/pip-h20xXG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:43:13 INFO - Running setup.py (path:/tmp/pip-6b5tbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:43:13 INFO - Running setup.py (path:/tmp/pip-Hy1BGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:43:13 INFO - Running setup.py (path:/tmp/pip-j1G8vD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:43:13 INFO - Running setup.py (path:/tmp/pip-LFkmyf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:43:13 INFO - Running setup.py (path:/tmp/pip-Wt0WKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:43:13 INFO - Running setup.py (path:/tmp/pip-0OoTz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:43:13 INFO - Running setup.py (path:/tmp/pip-uaxEGy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:43:13 INFO - Running setup.py (path:/tmp/pip-VcacJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:43:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:43:13 INFO - Running setup.py install for manifestparser 13:43:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:43:13 INFO - Running setup.py install for mozcrash 13:43:13 INFO - Running setup.py install for mozdebug 13:43:14 INFO - Running setup.py install for mozdevice 13:43:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for mozfile 13:43:14 INFO - Running setup.py install for mozhttpd 13:43:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for mozinfo 13:43:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for mozInstall 13:43:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for mozleak 13:43:14 INFO - Running setup.py install for mozlog 13:43:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for moznetwork 13:43:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:43:14 INFO - Running setup.py install for mozprocess 13:43:14 INFO - Running setup.py install for mozprofile 13:43:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:43:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:43:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:43:15 INFO - Running setup.py install for mozrunner 13:43:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:43:15 INFO - Running setup.py install for mozscreenshot 13:43:15 INFO - Running setup.py install for moztest 13:43:15 INFO - Running setup.py install for mozversion 13:43:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:43:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:15 INFO - Cleaning up... 13:43:15 INFO - Return code: 0 13:43:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:15 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:15 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 13:43:15 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 13:43:15 INFO - Using env: {'DISPLAY': ':0', 13:43:15 INFO - 'HOME': '/home/cltbld', 13:43:15 INFO - 'LANG': 'en_US.UTF-8', 13:43:15 INFO - 'LANGUAGE': 'en_US:en', 13:43:15 INFO - 'LOGNAME': 'cltbld', 13:43:15 INFO - 'MAIL': '/var/mail/cltbld', 13:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:15 INFO - 'MOZ_NO_REMOTE': '1', 13:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:15 INFO - 'NO_EM_RESTART': '1', 13:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:15 INFO - 'SHELL': '/bin/bash', 13:43:15 INFO - 'SHLVL': '1', 13:43:15 INFO - 'TERM': 'linux', 13:43:15 INFO - 'TMOUT': '86400', 13:43:15 INFO - 'USER': 'cltbld', 13:43:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:15 INFO - '_': '/tools/buildbot/bin/python'} 13:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:43:15 INFO - Running setup.py (path:/tmp/pip-kQcCcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:43:15 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)) 13:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:43:15 INFO - Running setup.py (path:/tmp/pip-iKmo1P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:43:15 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)) 13:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:43:15 INFO - Running setup.py (path:/tmp/pip-VDBbH_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:43:15 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)) 13:43:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:43:15 INFO - Running setup.py (path:/tmp/pip-4dIawl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:43:16 INFO - Running setup.py (path:/tmp/pip-1AGR8a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:43:16 INFO - Running setup.py (path:/tmp/pip-iPPo0g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:43:16 INFO - Running setup.py (path:/tmp/pip-6RAPHJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:43:16 INFO - Running setup.py (path:/tmp/pip-uJSdx4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:43:16 INFO - Running setup.py (path:/tmp/pip-ya9oT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:43:16 INFO - Running setup.py (path:/tmp/pip-01SnMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:43:16 INFO - Running setup.py (path:/tmp/pip-snMbNX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:43:16 INFO - Running setup.py (path:/tmp/pip-gVuwtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:43:16 INFO - Running setup.py (path:/tmp/pip-d4OUvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:43:16 INFO - Running setup.py (path:/tmp/pip-YNSTxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:43:16 INFO - Running setup.py (path:/tmp/pip-DHxYUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:43:16 INFO - Running setup.py (path:/tmp/pip-RRHxSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:43:16 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)) 13:43:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:43:16 INFO - Running setup.py (path:/tmp/pip-DBznT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:43:16 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)) 13:43:16 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)) 13:43:16 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)) 13:43:16 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)) 13:43:16 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)) 13:43:16 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)) 13:43:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:16 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 13:43:16 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 13:43:16 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 13:43:16 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 13:43:16 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 13:43:16 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 13:43:18 INFO - Downloading blessings-1.6.tar.gz 13:43:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:18 INFO - Installing collected packages: blessings 13:43:18 INFO - Running setup.py install for blessings 13:43:19 INFO - Successfully installed blessings 13:43:19 INFO - Cleaning up... 13:43:19 INFO - Return code: 0 13:43:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:43:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:43:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:43:19 INFO - Reading from file tmpfile_stdout 13:43:19 INFO - Current package versions: 13:43:19 INFO - argparse == 1.2.1 13:43:19 INFO - blessings == 1.6 13:43:19 INFO - blobuploader == 1.2.4 13:43:19 INFO - docopt == 0.6.1 13:43:19 INFO - manifestparser == 1.1 13:43:19 INFO - mozInstall == 1.12 13:43:19 INFO - mozcrash == 0.17 13:43:19 INFO - mozdebug == 0.1 13:43:19 INFO - mozdevice == 0.48 13:43:19 INFO - mozfile == 1.2 13:43:19 INFO - mozhttpd == 0.7 13:43:19 INFO - mozinfo == 0.9 13:43:19 INFO - mozleak == 0.1 13:43:19 INFO - mozlog == 3.1 13:43:19 INFO - moznetwork == 0.27 13:43:19 INFO - mozprocess == 0.22 13:43:19 INFO - mozprofile == 0.28 13:43:19 INFO - mozrunner == 6.11 13:43:19 INFO - mozscreenshot == 0.1 13:43:19 INFO - mozsystemmonitor == 0.0 13:43:19 INFO - moztest == 0.7 13:43:19 INFO - mozversion == 1.4 13:43:19 INFO - psutil == 3.1.1 13:43:19 INFO - requests == 1.2.3 13:43:19 INFO - wsgiref == 0.1.2 13:43:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:19 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:19 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 13:43:19 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 13:43:19 INFO - Using env: {'DISPLAY': ':0', 13:43:19 INFO - 'HOME': '/home/cltbld', 13:43:19 INFO - 'LANG': 'en_US.UTF-8', 13:43:19 INFO - 'LANGUAGE': 'en_US:en', 13:43:19 INFO - 'LOGNAME': 'cltbld', 13:43:19 INFO - 'MAIL': '/var/mail/cltbld', 13:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:19 INFO - 'MOZ_NO_REMOTE': '1', 13:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:19 INFO - 'NO_EM_RESTART': '1', 13:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:19 INFO - 'SHELL': '/bin/bash', 13:43:19 INFO - 'SHLVL': '1', 13:43:19 INFO - 'TERM': 'linux', 13:43:19 INFO - 'TMOUT': '86400', 13:43:19 INFO - 'USER': 'cltbld', 13:43:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:19 INFO - '_': '/tools/buildbot/bin/python'} 13:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 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)) 13:43:19 INFO - Cleaning up... 13:43:19 INFO - Return code: 0 13:43:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:19 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:19 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 13:43:19 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 13:43:19 INFO - Using env: {'DISPLAY': ':0', 13:43:19 INFO - 'HOME': '/home/cltbld', 13:43:19 INFO - 'LANG': 'en_US.UTF-8', 13:43:19 INFO - 'LANGUAGE': 'en_US:en', 13:43:19 INFO - 'LOGNAME': 'cltbld', 13:43:19 INFO - 'MAIL': '/var/mail/cltbld', 13:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:19 INFO - 'MOZ_NO_REMOTE': '1', 13:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:19 INFO - 'NO_EM_RESTART': '1', 13:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:19 INFO - 'SHELL': '/bin/bash', 13:43:19 INFO - 'SHLVL': '1', 13:43:19 INFO - 'TERM': 'linux', 13:43:19 INFO - 'TMOUT': '86400', 13:43:19 INFO - 'USER': 'cltbld', 13:43:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:19 INFO - '_': '/tools/buildbot/bin/python'} 13:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:19 INFO - Downloading/unpacking jsonschema 13:43:19 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 13:43:19 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 13:43:19 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 13:43:19 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 13:43:19 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 13:43:19 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 13:43:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:43:21 INFO - Downloading/unpacking functools32 (from jsonschema) 13:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:21 INFO - Downloading functools32-3.2.3-2.tar.gz 13:43:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:43:21 INFO - warning: no files found matching '*.txt' 13:43:21 INFO - no previously-included directories found matching 'build' 13:43:21 INFO - no previously-included directories found matching 'dist' 13:43:21 INFO - no previously-included directories found matching '.git*' 13:43:21 INFO - Installing collected packages: jsonschema, functools32 13:43:21 INFO - Running setup.py install for functools32 13:43:22 INFO - warning: no files found matching '*.txt' 13:43:22 INFO - no previously-included directories found matching 'build' 13:43:22 INFO - no previously-included directories found matching 'dist' 13:43:22 INFO - no previously-included directories found matching '.git*' 13:43:22 INFO - Successfully installed jsonschema functools32 13:43:22 INFO - Cleaning up... 13:43:22 INFO - Return code: 0 13:43:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:22 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 0x7fc373271f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb26d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, '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': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', '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 13:43:22 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 13:43:22 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 13:43:22 INFO - Using env: {'DISPLAY': ':0', 13:43:22 INFO - 'HOME': '/home/cltbld', 13:43:22 INFO - 'LANG': 'en_US.UTF-8', 13:43:22 INFO - 'LANGUAGE': 'en_US:en', 13:43:22 INFO - 'LOGNAME': 'cltbld', 13:43:22 INFO - 'MAIL': '/var/mail/cltbld', 13:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:22 INFO - 'MOZ_NO_REMOTE': '1', 13:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:22 INFO - 'NO_EM_RESTART': '1', 13:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:22 INFO - 'SHELL': '/bin/bash', 13:43:22 INFO - 'SHLVL': '1', 13:43:22 INFO - 'TERM': 'linux', 13:43:22 INFO - 'TMOUT': '86400', 13:43:22 INFO - 'USER': 'cltbld', 13:43:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:22 INFO - '_': '/tools/buildbot/bin/python'} 13:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:22 INFO - Downloading/unpacking flake8 13:43:22 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 13:43:22 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 13:43:22 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 13:43:22 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 13:43:22 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 13:43:22 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 13:43:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:43:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:43:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:43:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:24 INFO - no previously-included directories found matching 'docs/_build' 13:43:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:43:24 INFO - Running setup.py install for pep8 13:43:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:43:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:43:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:43:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:43:24 INFO - no previously-included directories found matching 'docs/_build' 13:43:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:43:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:43:24 INFO - Cleaning up... 13:43:25 INFO - Return code: 0 13:43:25 INFO - Running post-action listener: _resource_record_post_action 13:43:25 INFO - Running post-action listener: _start_resource_monitoring 13:43:25 INFO - Starting resource monitoring. 13:43:25 INFO - ##### 13:43:25 INFO - ##### Running install step. 13:43:25 INFO - ##### 13:43:25 INFO - Running pre-action listener: _resource_record_pre_action 13:43:25 INFO - Running main action method: install 13:43:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:43:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:43:25 INFO - Reading from file tmpfile_stdout 13:43:25 INFO - Detecting whether we're running mozinstall >=1.0... 13:43:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:43:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:43:25 INFO - Reading from file tmpfile_stdout 13:43:25 INFO - Output received: 13:43:25 INFO - Usage: mozinstall [options] installer 13:43:25 INFO - Options: 13:43:25 INFO - -h, --help show this help message and exit 13:43:25 INFO - -d DEST, --destination=DEST 13:43:25 INFO - Directory to install application into. [default: 13:43:25 INFO - "/builds/slave/test-pgo"] 13:43:25 INFO - --app=APP Application being installed. [default: firefox] 13:43:25 INFO - mkdir: /builds/slave/test-pgo/build/application 13:43:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:43:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:43:40 INFO - Reading from file tmpfile_stdout 13:43:40 INFO - Output received: 13:43:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:43:40 INFO - Running post-action listener: _resource_record_post_action 13:43:40 INFO - ##### 13:43:40 INFO - ##### Running run-tests step. 13:43:40 INFO - ##### 13:43:40 INFO - Running pre-action listener: _resource_record_pre_action 13:43:40 INFO - Running main action method: run_tests 13:43:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:43:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:43:40 INFO - Python 2.7.3 13:43:40 INFO - Return code: 0 13:43:40 INFO - grabbing minidump binary from tooltool 13:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:40 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 0x1c41920>, '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 0x1c42820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c42cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:43:40 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 13:43:40 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 13:43:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:40 INFO - Return code: 0 13:43:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:43:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:43:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:43:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:43:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:43:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:43:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:43:41 INFO - Return code: 0 13:43:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:43:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 13:43:41 INFO - Using env: {'DISPLAY': ':0', 13:43:41 INFO - 'HOME': '/home/cltbld', 13:43:41 INFO - 'LANG': 'en_US.UTF-8', 13:43:41 INFO - 'LANGUAGE': 'en_US:en', 13:43:41 INFO - 'LOGNAME': 'cltbld', 13:43:41 INFO - 'MAIL': '/var/mail/cltbld', 13:43:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:43:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:41 INFO - 'MOZ_NO_REMOTE': '1', 13:43:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:43:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:41 INFO - 'NO_EM_RESTART': '1', 13:43:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:43:41 INFO - 'PWD': '/builds/slave/test-pgo', 13:43:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:43:41 INFO - 'SHELL': '/bin/bash', 13:43:41 INFO - 'SHLVL': '1', 13:43:41 INFO - 'TERM': 'linux', 13:43:41 INFO - 'TMOUT': '86400', 13:43:41 INFO - 'USER': 'cltbld', 13:43:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287', 13:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:41 INFO - '_': '/tools/buildbot/bin/python'} 13:43:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 13:43:42 INFO - mozversion application_buildid: 20160310105922 13:43:42 INFO - mozversion application_changeset: abdbe1190ce3b25fabe31899864e57cd6fff6623 13:43:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:43:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:42 INFO - mozversion application_name: Firefox 13:43:42 INFO - mozversion application_remotingname: firefox-dev 13:43:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:43:42 INFO - mozversion application_vendor: Mozilla 13:43:42 INFO - mozversion application_version: 47.0a2 13:43:42 INFO - mozversion platform_buildid: 20160310105922 13:43:42 INFO - mozversion platform_changeset: abdbe1190ce3b25fabe31899864e57cd6fff6623 13:43:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:43:42 INFO - mozversion platform_version: 47.0a2 13:43:42 INFO - using testdate: 1457646222 13:43:42 INFO - actual date: 1457646222 13:43:42 INFO - starting webserver on 'localhost:56327' 13:43:42 INFO - SUITE-START | Running 2 tests 13:43:42 INFO - TEST-START | dromaeo_css 13:43:42 INFO - operating with platform_type : linux_ 13:43:42 INFO - Initialising browser for dromaeo_css test... 13:43:42 INFO - TEST-INFO | started process 3296 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_nboQ6/profile http://localhost:56327/getInfo.html) 13:43:47 INFO - PROCESS | 3296 | __metrics Screen width/height:1600/1200 13:43:47 INFO - PROCESS | 3296 | colorDepth:24 13:43:47 INFO - PROCESS | 3296 | Browser inner width/height: 1024/697 13:43:47 INFO - PROCESS | 3296 | __metrics 13:43:48 INFO - PROCESS | 3296 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:43:49 INFO - TEST-INFO | 3296: exit 0 13:43:49 INFO - Browser initialized. 13:43:49 INFO - Running cycle 1/1 for dromaeo_css test... 13:43:49 INFO - TEST-INFO | started process 3386 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_nboQ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:00 INFO - PROCESS | 3386 | RSS: Main: 143806464 13:44:00 INFO - PROCESS | 3386 | 13:44:52 INFO - PROCESS | 3386 | 1457646292011 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] 13:46:59 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56327/tests/dromaeo/cssquery-ext.html) 13:47:00 INFO - PROCESS | 3386 | RSS: Main: 259801088 13:47:00 INFO - PROCESS | 3386 | 13:50:02 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-ext.html (next: http://localhost:56327/tests/dromaeo/cssquery-jquery.html) 13:50:03 INFO - PROCESS | 3386 | RSS: Main: 227627008 13:50:03 INFO - PROCESS | 3386 | 13:53:05 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56327/tests/dromaeo/cssquery-mootools.html) 13:53:06 INFO - PROCESS | 3386 | RSS: Main: 224419840 13:53:06 INFO - PROCESS | 3386 | 13:56:07 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56327/tests/dromaeo/cssquery-prototype.html) 13:56:08 INFO - PROCESS | 3386 | RSS: Main: 199630848 13:56:08 INFO - PROCESS | 3386 | 13:59:10 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56327/tests/dromaeo/cssquery-yui.html) 13:59:11 INFO - PROCESS | 3386 | RSS: Main: 217640960 13:59:11 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:56327/tests/dromaeo/cssquery-yui.html (next: http://localhost:56327/tests/dromaeo/cssquery-dojo.html) 14:02:13 INFO - PROCESS | 3386 | RSS: Main: 258035712 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | __start_tp_report 14:02:13 INFO - PROCESS | 3386 | _x_x_mozilla_page_load 14:02:13 INFO - PROCESS | 3386 | _x_x_mozilla_page_load_details 14:02:13 INFO - PROCESS | 3386 | |i|pagename|runs| 14:02:13 INFO - PROCESS | 3386 | |0;dojo.html;3233.6442991270965;3257.8371081445953;3261.755368347373;3297.6702329767027;3316.8009919404835;5273.235380869772;5287.603429742765;5305.257263983036;5319.388270348911;5352;5306.230596563496;5317.149256119022;5332;5333;5342.465753424655;4852.053849499349;4867.221244600864;4889.022195560893;4912.287718280847;4912.435069966946;4890.21756518957;4937.679050861682;4939.555440010398;4941.3329200558;4950.207966725325;4953.356063711731;5013.298138260647;5022.924656130161;5030.220315851049;5051.747412629372;4485.932711009337;5027.723475208862;5053.823116190915;5057.291979122907;5061.949380506203;4843.854684359475;4917.336159618477;4919.72941488218;4930.211166213388;4955.752212389366;5236.266922630834;5264.947350526484;5266.262723218714;5271.472852714736;5303.071962406602;5623.8594035149035;5698.116791897221;5782;5818.709064546798;5833;5832.620879642852;5843.678597677126;5867.471927526501;5870.11948207768;5881.382454842265;5462.644928079662;5468.945310546923;5476.7535460903955;5479.013777520045;5486.670799751988;5736.713164341766;5923.259592550931;6007.8197654070445;6009.308929473166;6026.608270462406;5728.51307638847;5753.223314852441;5753.510951569164;5754.712264386764;5765.04876695349;5828.358880523139;5841.269841269841;5846.152307915413;5854.677992710356;5858.707064646751;5571.331440227118;5704.857378565569;5753.223314852525;5757.366689664133;5759.596828221985;5751.252337196222;5752.36723960364;5761.683107429131;5764.164196191613;5766.135079738073;4282.678799090018;4406.691531592822;4407.713498622579;4410.236521929343;4436.3123715824095;3941.1132495188353;3991.7604943703473;4004.799760011988;4011.458453108793;4035.414864844581;5438.564914806806;5445.482679145475;5447.046766815792;5457.590680698963;5461.2354270402175;5746.0519014363;5824.970875145597;5847.386024467455;5847.473727364558;5851.64890106595;5427.972860135674;5440.700761458158;5451.918221226685;5460.399356070829;5500.532454741392;4957.876053098629;4963.45402005779;4963.851084467472;4968.403791545038;4999.325091112726;5782.826515204551;5995.46040856325;6013.248343957005;6014.578979471395;6078.574499784972;5883.176355310346;5885.499732522783;5921.911171332519;5922.2597175353085;5924.733386997509;5954.136650185786;6022.7289771959495;6057.515398768;6061.6666083365835;6072.240969878765;5599.692016939108;5659.971700141473;5725.570582206268;5765.135229715576;5780.682062486603;5867.178594996619;5884.382139875423;5887.264091988502;5887.322957859729;5889.94110058894;5692.459216374438;5717.22817419643;5718.885622287614;5718.942810571841;5747.281589801275;5511.641743286834;5713.428657134419;5736.569757268138;5786.797462088806;5814.563907707024;5669.404712505293;5683.23276357703;5694.829155125353;5700.942990570207;5726.513246374105;5599.188117722989;5780.508656764222;5794.913076303775;5800.883982320414;5810.389909059657;5410.918836217538;5489.560835133259;5559.0827513461445;5608.495235428831;5614.7192640367 14:02:13 INFO - PROCESS | 3386 | |1;ext.html;526.3815017354608;542.0541155683334;553.6014069869694;558.3997203006769;572.8224250482353;31672.366552668962;38707.61292387075;39222.21555568887;39242.80378598103;39301.80349098251;46270;46890.29664555034;47021;47022.52977470224;47061.52938470614;8899.599518021689;9193.494357810318;9198.724038278862;9199.264058875275;9200.723978280663;8883.689070882521;9007.774805629846;9023.142801433853;9033;9035.503047332393;9000.099990001014;9040.954795226015;9086.727398178065;9087.363884528086;9089.409188402766;8944.373893827402;9017.233535149455;9023.4134781239;9034.774130646721;9035.141661542177;9005.684801031932;9126.908730912672;9129.041450647654;9139.497327646977;9145.085491450802;42356;42688.57311426877;42713.145737085084;42800.143997119885;42830.57169428297;3742.270257299828;3830.559485659157;3981.6018398159954;4225.746455212667;4256.5105012923605;33813;33937.49093763596;34150.82924585386;34163.487547686804;34423.48364774531;3887.319719049155;3924.4701965234613;3944.3294639911283;4011.4785077939973;4217.072244106292;227432;229320;229940;230698;231303.9999999983;59116;59810;59945;59986.400135998956;65317.346826531124;76593.6170319156;77085;77581.22418775853;77653;77747;15581.844181558039;15841.920790395974;15897.443589474544;15931.12378819176;15932.522024339289;11872;11884.465199066062;11898.643040708792;11907.166498345032;11931.343776092224;22508.54982900333;22829.543409132057;22851;22893.885530572574;22909.770902290762;7968.920310796818;8250.793730156794;8259.876101858477;8317.542535160625;8449.112843151504;991.251605038206;1038.771470276538;1045.2160879340495;1050.5902697947806;1142.5486932661718;29912.85043574768;30058.24854378658;30364.54453183204;30838.845805770827;30856.69143308583;1109.3953795181646;1131.4060118437885;1146.644540192543;1157.9536818527333;1206.831043653889;15799.526014219591;15928.76106858398;16099.758503622455;16135.193240337936;16316.265768040466;340385;344004;344915;344953;345197;55327.44672553303;55727;56395;56459;56568;1227.5642147037672;1350;1436.655202751353;1464.9560513184622;1464.978025329621;28521.42957140887;29883.850580746956;29894.551581725857;30192.396152076395;30625.23436914095;43709.78145109254;44533;45518;45663;45710.77144614256;238453;239339;240094;240287;282682;34003.319933600695;34183.82908085443;34654.82672586621;34793.47809782906;35144.297114057066;41354.586454135075;42210.36684449674;50294.748526257135;52745.20882186847;53062.46937530575;36929.26141477209;37133.25733485261;37227.255454891296;37327;37372.439413408276;39487.407688884115;40062.599374007055;40245.79877100713;40353;40771.796141019106;39803;39861.2027759449;40249.19501609893;40659.186816264104;40833.18333633251;35787.64212357947;36542;37249.44125838169;37274.813625931696;37316;27949.580756288266;28841.567376489787;28903.828589395504;28956.42087158287;29156.7084329154 14:02:13 INFO - PROCESS | 3386 | |2;jquery.html;376.87374729465637;378.8522476234269;390.52161102649256;394.86574564648015;397.5289282200591;17675.078645218262;19401.902990485047;19842.710223835442;19947.50131246718;19990.50023749407;17955;18171.182296796644;18398.816011839877;18539.629207415845;18554.53613659659;5681.7727290908315;5835.912461313083;5840.240768700063;5870.941290587103;5877.85305367365;4339.500957389893;6274.968625156891;6557.409833115019;6587.7364905403965;6590.373914478141;6446.677666116699;6505.902411463831;6531.771388001421;6563;6566.1464009678675;6314.905276420857;6461.5153863459955;6477.093206951031;6484.805455836309;6504.577202481847;3931.8820435386983;4086.3053280942013;5471.50756431919;5689.175069614883;5689.687067211302;12808.231506109663;13399.799003014963;13414;22129.44676383087;22131;2250.5161390301;2295.0934380919443;2340.941476463085;2426.4419183587697;2877.949548414834;9288.442693438416;9952.950235248778;9978.800423991479;10258.846117308247;10586.41774702391;1921.990390048055;1955.2765476773543;1958.921643134273;1989.5821877405617;2021.0299056452839;67929.98105028429;68304.6584767078;68572.3142768571;68677.3132268676;68872.655636722;10580.407800089028;10683;10803.891961080446;11047.779044419227;11262.887371126184;14986.47547335838;15003.399864005536;15034.398624054915;15043.323050462755;15047.247637618295;7527.510711803715;7596.088469383599;7745.922540774633;7841.5687137208;8007.959960200162;6379.872402552016;6438.77464288757;6475.4819614430735;7007.054047703597;7198.928010719826;4369.694121411534;4794.7842347093765;4860.3195552621955;4902.7058376497525;4968.22992436173;1582.0507695382908;1617.6198593330557;1674.2382216091648;1732.3070771691173;1779.350537053992;962;963.9710808675751;986.5609803637312;1004.487711267259;1026.5072765072807;15960.600984975235;16888.83111168897;17619.735703964452;18024.639507209784;18122.546936326435;984.1142971325721;1028.7942411517727;1034.374203606822;1046.0219694585587;1052.4211683574003;9822.263330250116;9993.450360230258;10104.09063184317;10164.898351016544;10291.53688084038;462868;481502;486465;490312;491836;62500.68749656223;78806;81416.59291703504;81702;81994.18005819866;1039.6413237433073;1050.0444595418132;1051.374432212832;1063.9787204255872;1064.3135177810268;15594;15606.9219653901;15834.841651583798;15879.68240635204;16041.598960026093;33322.333553329285;34348.31303373969;34671;35409.46885796663;35506.46740298846;42261.788691057576;44562.77718611386;45455.31817022681;45780.542194577625;47314.763426182646;7501.137369202612;7804.726834560764;7867.331276841533;7962.800929976797;8213;9335;10640.52117654692;12813.167144135601;12969.935150324189;12987.41556629935;8946.910530894607;10014;10683.30558513694;11686.415679216176;11801.881981180079;11739.941300293785;11766.117541184274;12080.03359731237;12140.39298035077;12145.210561313486;12139.39303034827;12212.633620991384;12223.44994475233;12225.633231003085;12284.38578071075;8166.550839703873;8273.46222495536;8426.747197584082;8434.620442079999;8575.356848236283;10350.896491034993;12106.213096148722;12147.57483488109;12277.324747138993;12365 14:02:13 INFO - PROCESS | 3386 | |3;mootools.html;1449.9565013049598;1567.6159340961462;1580.5495433801366;1815.292036105919;1929.488685498343;7996.320312773414;8328.042275138361;8349.95825020874;8354.456960297577;8383.371247156458;8185.836283274346;8310.95844520778;8325.417220794547;8336;8343.833123337545;2146.6887301341294;2202.2622421488823;2448;2453.1904471524444;2486.11742831295;2484.6024636058232;2489;2497.900083996638;2500.9374765630914;2501.049601151569;2401.1835975768236;2420.987895060522;2451.656768052474;2469.1481438903547;2471.085698291635;2436.84160529565;2455.5579995600783;2466.235467005225;2466.8889899954547;2487.0549191307186;2457.2751038443703;2461.716902556211;2476.4675594747036;2484.3043947694673;2491.202815099169;8533.274671652916;8584.27033702136;8589.312854971588;8590.140985901422;8591.785205369853;5204.34945631796;5321.893562128775;5328.866778330534;5331.253624492574;5333.786648534054;3368.831558422069;3373.3759254537745;3434.639362866913;3439.6216416194197;3501.9474707879403;1042.968710938673;1081.313151483688;1086.3536195963388;1108.539955918293;1110.722319420145;12247.387630618523;12260.386980651021;12269.509219631203;12281.385930703518;12292.877071229263;4743.833965811249;4769.475357710649;4817.0365926814775;4841.636877234151;4861.076395484846;10001;10055.145312648361;10067.194624430029;10069.597216111273;10085.747856303504;5259.868503287372;5279.313689220454;5289.788408463618;5303.36359636846;5306.575473962073;4188.204241194163;4322.308430651081;4720.929186062212;4764.523547645208;4783.425988881357;3945.2109578084496;4011.7592944423427;4022.9798851005557;4049.716519843583;4083.9183216335505;1248.2448118888124;1255.535451882791;1255.8806913343217;1262.501311981762;1264.8292480515197;1186.8694443611196;1188.3167178872184;1207.034372501995;1438.439008786574;1502.346479281516;8189.262966333059;8232.62953167109;8327.916720832834;8342.916570834213;8344.41589088758;522.7804322184692;524.8950209957948;526.2422112158556;528.9603279754034;536.4421002157791;5936.762529498858;5999.190109335271;6012.278526576752;6052.182955300978;6063.090536419572;9983.900160998297;10012.499375031219;10145.797084058426;10166.745831354276;10181.490925453698;9845.50772461374;9962.103410693073;9995.300328976902;9998.300118991601;10015.148712359385;7945.165757595485;8051.879221811678;8054.879176812353;8094.3929205311015;8150.266476017068;7814.4529882907655;7918.2477664621765;7977.441579089408;8081.757547273592;8097.190280971856;9262.768430789285;9285.396449230779;9362.485063321583;9363.672271470467;9463.337566370288;9316.860247096434;9527.523623818919;9701.175400091071;9705.12653861156;9712.223022158352;6637.336266373324;7202;7381.446391520765;7444.404447644067;7512.39900807945;8047.597620118853;8049.959750201211;8050.959745201237;8065.435419520577;8092.069412017693;7106.5736055836815;7288.817779555554;7368.963155184404;7507.061617297838;7510.474266801271;7240.384567311627;7320.194778574459;7377.5204611700065;7514.098308203051;7594.544327340377;7928.167542408195;7938.087119981276;7987.241212084843;7996.280334769898;7997.440179187401;7244.058272424551;7297.63511824396;7342.6695798688115;7390.5196162249285;7396.223396543501;7356.4114870809135;7377.631118443949;7405.703771849066;7436.070491188601;7442.4418168636485 14:02:13 INFO - PROCESS | 3386 | |4;prototype.html;329.5320644684548;334.88111720339293;335.73644688919205;338.61567121317313;340.4467739922626;6046.062860256662;6047;6077.02767557191;6084.239470066236;6107.2976607690125;5992.34084250732;6002.339742628307;6006.57953943223;6015.6992150392525;6021.578489505737;4483.955160448387;4521.502634710179;4575.062112266994;4642.396488456496;4674.415698037746;4634.281686338606;4653.325267836161;4661.813527458898;4662.347271382009;4662.953370466303;4610.97694511527;4617.699849509788;4620.468646105691;4621.491635920046;4637;4464.397306363632;4523.864284071483;4617.30740388941;4618.237990731525;4645.0477652081245;4035;4051.8379264829373;4054.1891621675486;4062.614051665087;4073.816678249486;5751.511121554673;5751.654900705929;5762.279715035621;5767.5962682612235;5772.30732312121;5385.730713464351;5390.703511306916;5396.298481197419;5397.676139431646;5403.7027963462;6372.2671892732005;6404.743810247584;6408.198975128109;6409.743610255584;6411.262704788963;4320.200762858881;4460.1525710114975;4460.15257101153;4462.3752674625575;4496.3705081288645;6652.966735166293;6702.620569697785;6706.128203333536;6716.597004179716;6718.328167183291;4587.243104887723;4587.288970209623;4587.770611469413;4589.79345929434;4598.517155698671;4651.906961860744;4653.418322709661;4653.7207767534055;4655.4878963314;4656.301554766812;5368.489993450616;5376.005438993799;5381.192821076792;5387.784488620489;5387.784488620489;6329.905051424233;6462.709178086998;6470.352964703586;6479.902801457982;6488.929326661142;1594.067470529753;1599.4561848971405;1607.5177446766156;1607.734723770588;1608.340580362046;988.110700369673;1059.7191744187796;1068.3750006246278;1084.9349039057681;1085.766560189563;6113.083037544404;6123.203983482119;6162.876742465126;6177.62934223948;6178.135061091451;6658;6658.03458498515;6660.467162626978;6666.166729158856;6668.166479190101;6176.073588961602;6176.845578860474;6180.536459765535;6183.319834818167;6193.783217587453;3559.14580500678;3559.60844307126;3561.5013898054294;3569.3396721606587;3592.191756854739;6651.135352404156;6813.386795188457;6876.69054892521;6880.862382752317;6883.449324054063;6664.333566643297;6728.932710672929;6751.358620931003;6770.932290677129;6778.118844550276;6779.5254332197255;6797.932020679828;6830.872905970459;6844.8973265401055;6846.486513511507;6635.435987940886;6639.336066393322;6649;6654.767083152066;6654.933450665431;6402.423781859655;6533.738650454119;6544.116544266463;6551.213854337319;6551.737930482727;6800.31996800316;6822.351876571718;6844;6844.657767111724;6852.691628876612;4561.817527298871;4567.132244873464;4571.657125715518;4572.565606267399;4573.199690054294;6641.1034510342415;6644.7009884554345;6648.933510664831;6649.035889795856;6651.667416629246;6286.245650521967;6481.740730370921;6516.967415162894;6526.053722210158;6546.214454265519;6418.93581064202;6421.935780642134;6457.354264573505;6462.386073323027;6465.321141280097;6311;6321.5258855586935;6322.114903913363;6323.241211054519;6343.619382837044;6444.45222156122;6454.741810327534;6466.450351719968;6467.967660161858;6468.062130991074;6167.938320616916;6226.12834203221;6267.811965641038;6274.968625156845;6306.779262725782 14:02:13 INFO - PROCESS | 3386 | |5;yui.html;780.6643143448317;794.614611913222;818.1000899011085;833.2209384225753;905.8414777413951;15922.601934951632;16056.357745690158;16059.437919672813;16090.839091609081;16147.111908845009;15101.697966040672;15243.31405086771;15331.463398781045;15349.462768803094;15356.923215383935;776.6543887969856;915.5147771680986;915.7527467583749;929.9395539289925;935.088288918306;930.6044930904372;936.967206147785;940.9717708468756;941.7692665297012;942.189716843514;980.5685498380725;981.9754506137332;983.1102851918989;985.8422652375622;986.0435377683672;807.3944541593804;961.8941916389192;979.9804003919882;983.572146116438;986.2011770465874;718.3175982816293;718.5006420537728;718.881384571545;719.3058698356111;719.6761457344217;12749.490020399173;12796.61610151697;12858.357082145856;12922.095453318272;12957.740845183138;12659;12773.233605983578;12821.67945801353;13014.47942082325;13044.217346959213;10911.399873006982;11044.558217671363;11052.502637381338;11164.218504704673;12101.757964840654;3574.6246644102257;3604.2611264690677;3623.0942264433893;3626.4560315952554;3855.8843234703004;56822;56896.71551642257;57222.42777572213;57379.42620573783;57469.13796293059;9340.4862732549;9423.623055077856;9458.716238512856;9649.276304277208;10373.118284945864;18569.628607428047;18582;18617.510599152036;18736.15687294048;18748.906255468635;7475.439342049368;7558.281963213486;7622.237776222333;7980.241877021674;8031.036275646959;4294.871153865389;4359.237133501624;4365.192439398658;4374.846880359172;4400.405945197357;3454.1882657575447;3460.048486666187;3464.965350346464;3469.479578063311;3471.8437670304897;589.8731772668897;593.4243783529969;630.4830039367766;646.0599827251338;684.3635419060222;583.6789765628887;630.3444417805523;648.4650163615037;649.5453182772078;658.3219284137347;8811.206991370807;8917.866232006525;8989.325800564984;9054.81890362189;9269.536523173949;661.6493258572964;676.3067855448106;678.4402867634221;679.6228093408107;692.4322055914103;4019.2765302245293;4225.535191128974;4286.678499112579;4346.673999450054;4373.147236288957;58242;59292.40707592955;60709;61057.389426106056;61544.69227653833;51615;51622.48377516252;52846.735766320926;53622;54293;46902;47490.28764568534;47545.286820697715;47926.76036619864;48449.75775121102;9271.490068046052;9389;9443.575039123394;9457.810843783223;9597.808043839224;35577;36064.27871442609;36798;37170;37795.81102094472;46138;47425.52574474349;47785.04429911452;47980.04039919112;48235.517644824504;11722.413879306172;11731.120165987755;11783;11783.410829458322;11800.52797888075;13376.732465350833;13474.730505390033;13547.390367433292;13615.931920340336;13887.58337249884;11365.261258018203;11488;11568.652940411801;11581.975643567388;12214;11915.406290761157;12019.63941081769;12085.335306558223;12285.631431057083;12375.195612285173;11912.702182445162;12063.155579109378;12209.328486932949;12232.327222002876;12450.626481205578;9711.5144242789;9724.319297649097;9827.164691001344;10020.198384129399;10037.69886903394;10450.372977621062;10573.207009474167;10611.681649550526;10669.46652667348;10752.247342686249 14:02:13 INFO - PROCESS | 3386 | __end_tp_report 14:02:13 INFO - PROCESS | 3386 | __start_cc_report 14:02:13 INFO - PROCESS | 3386 | _x_x_mozilla_cycle_collect,917 14:02:13 INFO - PROCESS | 3386 | __end_cc_report 14:02:13 INFO - PROCESS | 3386 | __startTimestamp1457647333788__endTimestamp 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | ------- Summary: start ------- 14:02:13 INFO - PROCESS | 3386 | Number of tests: 6 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#0] dojo.html Cycles:165 Average:5392.84 Median:5608.50 stddev:606.21 (10.8%) stddev-sans-first:583.92 14:02:13 INFO - PROCESS | 3386 | Values: 3233.6 3257.8 3261.8 3297.7 3316.8 5273.2 5287.6 5305.3 5319.4 5352.0 5306.2 5317.1 5332.0 5333.0 5342.5 4852.1 4867.2 4889.0 4912.3 4912.4 4890.2 4937.7 4939.6 4941.3 4950.2 4953.4 5013.3 5022.9 5030.2 5051.7 4485.9 5027.7 5053.8 5057.3 5061.9 4843.9 4917.3 4919.7 4930.2 4955.8 5236.3 5264.9 5266.3 5271.5 5303.1 5623.9 5698.1 5782.0 5818.7 5833.0 5832.6 5843.7 5867.5 5870.1 5881.4 5462.6 5468.9 5476.8 5479.0 5486.7 5736.7 5923.3 6007.8 6009.3 6026.6 5728.5 5753.2 5753.5 5754.7 5765.0 5828.4 5841.3 5846.2 5854.7 5858.7 5571.3 5704.9 5753.2 5757.4 5759.6 5751.3 5752.4 5761.7 5764.2 5766.1 4282.7 4406.7 4407.7 4410.2 4436.3 3941.1 3991.8 4004.8 4011.5 4035.4 5438.6 5445.5 5447.0 5457.6 5461.2 5746.1 5825.0 5847.4 5847.5 5851.6 5428.0 5440.7 5451.9 5460.4 5500.5 4957.9 4963.5 4963.9 4968.4 4999.3 5782.8 5995.5 6013.2 6014.6 6078.6 5883.2 5885.5 5921.9 5922.3 5924.7 5954.1 6022.7 6057.5 6061.7 6072.2 5599.7 5660.0 5725.6 5765.1 5780.7 5867.2 5884.4 5887.3 5887.3 5889.9 5692.5 5717.2 5718.9 5718.9 5747.3 5511.6 5713.4 5736.6 5786.8 5814.6 5669.4 5683.2 5694.8 5700.9 5726.5 5599.2 5780.5 5794.9 5800.9 5810.4 5410.9 5489.6 5559.1 5608.5 5614.7 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#1] ext.html Cycles:180 Average:46684.13 Median:21583.64 stddev:72805.72 (337.3%) stddev-sans-first:72927.47 14:02:13 INFO - PROCESS | 3386 | Values: 526.4 542.1 553.6 558.4 572.8 31672.4 38707.6 39222.2 39242.8 39301.8 46270.0 46890.3 47021.0 47022.5 47061.5 8899.6 9193.5 9198.7 9199.3 9200.7 8883.7 9007.8 9023.1 9033.0 9035.5 9000.1 9041.0 9086.7 9087.4 9089.4 8944.4 9017.2 9023.4 9034.8 9035.1 9005.7 9126.9 9129.0 9139.5 9145.1 42356.0 42688.6 42713.1 42800.1 42830.6 3742.3 3830.6 3981.6 4225.7 4256.5 33813.0 33937.5 34150.8 34163.5 34423.5 3887.3 3924.5 3944.3 4011.5 4217.1 227432.0 229320.0 229940.0 230698.0 231304.0 59116.0 59810.0 59945.0 59986.4 65317.3 76593.6 77085.0 77581.2 77653.0 77747.0 15581.8 15841.9 15897.4 15931.1 15932.5 11872.0 11884.5 11898.6 11907.2 11931.3 22508.5 22829.5 22851.0 22893.9 22909.8 7968.9 8250.8 8259.9 8317.5 8449.1 991.3 1038.8 1045.2 1050.6 1142.5 29912.9 30058.2 30364.5 30838.8 30856.7 1109.4 1131.4 1146.6 1158.0 1206.8 15799.5 15928.8 16099.8 16135.2 16316.3 340385.0 344004.0 344915.0 344953.0 345197.0 55327.4 55727.0 56395.0 56459.0 56568.0 1227.6 1350.0 1436.7 1465.0 1465.0 28521.4 29883.9 29894.6 30192.4 30625.2 43709.8 44533.0 45518.0 45663.0 45710.8 238453.0 239339.0 240094.0 240287.0 282682.0 34003.3 34183.8 34654.8 34793.5 35144.3 41354.6 42210.4 50294.7 52745.2 53062.5 36929.3 37133.3 37227.3 37327.0 37372.4 39487.4 40062.6 40245.8 40353.0 40771.8 39803.0 39861.2 40249.2 40659.2 40833.2 35787.6 36542.0 37249.4 37274.8 37316.0 27949.6 28841.6 28903.8 28956.4 29156.7 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#2] jquery.html Cycles:180 Average:27081.03 Median:34509.66 stddev:79068.33 (229.1%) stddev-sans-first:79264.71 14:02:13 INFO - PROCESS | 3386 | Values: 376.9 378.9 390.5 394.9 397.5 17675.1 19401.9 19842.7 19947.5 19990.5 17955.0 18171.2 18398.8 18539.6 18554.5 5681.8 5835.9 5840.2 5870.9 5877.9 4339.5 6275.0 6557.4 6587.7 6590.4 6446.7 6505.9 6531.8 6563.0 6566.1 6314.9 6461.5 6477.1 6484.8 6504.6 3931.9 4086.3 5471.5 5689.2 5689.7 12808.2 13399.8 13414.0 22129.4 22131.0 2250.5 2295.1 2340.9 2426.4 2877.9 9288.4 9953.0 9978.8 10258.8 10586.4 1922.0 1955.3 1958.9 1989.6 2021.0 67930.0 68304.7 68572.3 68677.3 68872.7 10580.4 10683.0 10803.9 11047.8 11262.9 14986.5 15003.4 15034.4 15043.3 15047.2 7527.5 7596.1 7745.9 7841.6 8008.0 6379.9 6438.8 6475.5 7007.1 7198.9 4369.7 4794.8 4860.3 4902.7 4968.2 1582.1 1617.6 1674.2 1732.3 1779.4 962.0 964.0 986.6 1004.5 1026.5 15960.6 16888.8 17619.7 18024.6 18122.5 984.1 1028.8 1034.4 1046.0 1052.4 9822.3 9993.5 10104.1 10164.9 10291.5 462868.0 481502.0 486465.0 490312.0 491836.0 62500.7 78806.0 81416.6 81702.0 81994.2 1039.6 1050.0 1051.4 1064.0 1064.3 15594.0 15606.9 15834.8 15879.7 16041.6 33322.3 34348.3 34671.0 35409.5 35506.5 42261.8 44562.8 45455.3 45780.5 47314.8 7501.1 7804.7 7867.3 7962.8 8213.0 9335.0 10640.5 12813.2 12969.9 12987.4 8946.9 10014.0 10683.3 11686.4 11801.9 11739.9 11766.1 12080.0 12140.4 12145.2 12139.4 12212.6 12223.4 12225.6 12284.4 8166.6 8273.5 8426.7 8434.6 8575.4 10350.9 12106.2 12147.6 12277.3 12365.0 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#3] mootools.html Cycles:180 Average:5973.94 Median:5325.38 stddev:3154.15 (59.2%) stddev-sans-first:3144.67 14:02:13 INFO - PROCESS | 3386 | Values: 1450.0 1567.6 1580.5 1815.3 1929.5 7996.3 8328.0 8350.0 8354.5 8383.4 8185.8 8311.0 8325.4 8336.0 8343.8 2146.7 2202.3 2448.0 2453.2 2486.1 2484.6 2489.0 2497.9 2500.9 2501.0 2401.2 2421.0 2451.7 2469.1 2471.1 2436.8 2455.6 2466.2 2466.9 2487.1 2457.3 2461.7 2476.5 2484.3 2491.2 8533.3 8584.3 8589.3 8590.1 8591.8 5204.3 5321.9 5328.9 5331.3 5333.8 3368.8 3373.4 3434.6 3439.6 3501.9 1043.0 1081.3 1086.4 1108.5 1110.7 12247.4 12260.4 12269.5 12281.4 12292.9 4743.8 4769.5 4817.0 4841.6 4861.1 10001.0 10055.1 10067.2 10069.6 10085.7 5259.9 5279.3 5289.8 5303.4 5306.6 4188.2 4322.3 4720.9 4764.5 4783.4 3945.2 4011.8 4023.0 4049.7 4083.9 1248.2 1255.5 1255.9 1262.5 1264.8 1186.9 1188.3 1207.0 1438.4 1502.3 8189.3 8232.6 8327.9 8342.9 8344.4 522.8 524.9 526.2 529.0 536.4 5936.8 5999.2 6012.3 6052.2 6063.1 9983.9 10012.5 10145.8 10166.7 10181.5 9845.5 9962.1 9995.3 9998.3 10015.1 7945.2 8051.9 8054.9 8094.4 8150.3 7814.5 7918.2 7977.4 8081.8 8097.2 9262.8 9285.4 9362.5 9363.7 9463.3 9316.9 9527.5 9701.2 9705.1 9712.2 6637.3 7202.0 7381.4 7444.4 7512.4 8047.6 8050.0 8051.0 8065.4 8092.1 7106.6 7288.8 7369.0 7507.1 7510.5 7240.4 7320.2 7377.5 7514.1 7594.5 7928.2 7938.1 7987.2 7996.3 7997.4 7244.1 7297.6 7342.7 7390.5 7396.2 7356.4 7377.6 7405.7 7436.1 7442.4 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#4] prototype.html Cycles:180 Average:5373.19 Median:6143.04 stddev:1621.49 (26.4%) stddev-sans-first:1581.23 14:02:13 INFO - PROCESS | 3386 | Values: 329.5 334.9 335.7 338.6 340.4 6046.1 6047.0 6077.0 6084.2 6107.3 5992.3 6002.3 6006.6 6015.7 6021.6 4484.0 4521.5 4575.1 4642.4 4674.4 4634.3 4653.3 4661.8 4662.3 4663.0 4611.0 4617.7 4620.5 4621.5 4637.0 4464.4 4523.9 4617.3 4618.2 4645.0 4035.0 4051.8 4054.2 4062.6 4073.8 5751.5 5751.7 5762.3 5767.6 5772.3 5385.7 5390.7 5396.3 5397.7 5403.7 6372.3 6404.7 6408.2 6409.7 6411.3 4320.2 4460.2 4460.2 4462.4 4496.4 6653.0 6702.6 6706.1 6716.6 6718.3 4587.2 4587.3 4587.8 4589.8 4598.5 4651.9 4653.4 4653.7 4655.5 4656.3 5368.5 5376.0 5381.2 5387.8 5387.8 6329.9 6462.7 6470.4 6479.9 6488.9 1594.1 1599.5 1607.5 1607.7 1608.3 988.1 1059.7 1068.4 1084.9 1085.8 6113.1 6123.2 6162.9 6177.6 6178.1 6658.0 6658.0 6660.5 6666.2 6668.2 6176.1 6176.8 6180.5 6183.3 6193.8 3559.1 3559.6 3561.5 3569.3 3592.2 6651.1 6813.4 6876.7 6880.9 6883.4 6664.3 6728.9 6751.4 6770.9 6778.1 6779.5 6797.9 6830.9 6844.9 6846.5 6635.4 6639.3 6649.0 6654.8 6654.9 6402.4 6533.7 6544.1 6551.2 6551.7 6800.3 6822.4 6844.0 6844.7 6852.7 4561.8 4567.1 4571.7 4572.6 4573.2 6641.1 6644.7 6648.9 6649.0 6651.7 6286.2 6481.7 6517.0 6526.1 6546.2 6418.9 6421.9 6457.4 6462.4 6465.3 6311.0 6321.5 6322.1 6323.2 6343.6 6444.5 6454.7 6466.5 6468.0 6468.1 6167.9 6226.1 6267.8 6275.0 6306.8 14:02:13 INFO - PROCESS | 3386 | 14:02:13 INFO - PROCESS | 3386 | [#5] yui.html Cycles:180 Average:14708.71 Median:47457.91 stddev:17058.81 (35.9%) stddev-sans-first:17074.60 14:02:13 INFO - PROCESS | 3386 | Values: 780.7 794.6 818.1 833.2 905.8 15922.6 16056.4 16059.4 16090.8 16147.1 15101.7 15243.3 15331.5 15349.5 15356.9 776.7 915.5 915.8 929.9 935.1 930.6 937.0 941.0 941.8 942.2 980.6 982.0 983.1 985.8 986.0 807.4 961.9 980.0 983.6 986.2 718.3 718.5 718.9 719.3 719.7 12749.5 12796.6 12858.4 12922.1 12957.7 12659.0 12773.2 12821.7 13014.5 13044.2 10911.4 11044.6 11052.5 11164.2 12101.8 3574.6 3604.3 3623.1 3626.5 3855.9 56822.0 56896.7 57222.4 57379.4 57469.1 9340.5 9423.6 9458.7 9649.3 10373.1 18569.6 18582.0 18617.5 18736.2 18748.9 7475.4 7558.3 7622.2 7980.2 8031.0 4294.9 4359.2 4365.2 4374.8 4400.4 3454.2 3460.0 3465.0 3469.5 3471.8 589.9 593.4 630.5 646.1 684.4 583.7 630.3 648.5 649.5 658.3 8811.2 8917.9 8989.3 9054.8 9269.5 661.6 676.3 678.4 679.6 692.4 4019.3 4225.5 4286.7 4346.7 4373.1 58242.0 59292.4 60709.0 61057.4 61544.7 51615.0 51622.5 52846.7 53622.0 54293.0 46902.0 47490.3 47545.3 47926.8 48449.8 9271.5 9389.0 9443.6 9457.8 9597.8 35577.0 36064.3 36798.0 37170.0 37795.8 46138.0 47425.5 47785.0 47980.0 48235.5 11722.4 11731.1 11783.0 11783.4 11800.5 13376.7 13474.7 13547.4 13615.9 13887.6 11365.3 11488.0 11568.7 11582.0 12214.0 11915.4 12019.6 12085.3 12285.6 12375.2 11912.7 12063.2 12209.3 12232.3 12450.6 9711.5 9724.3 9827.2 10020.2 10037.7 10450.4 10573.2 10611.7 10669.5 10752.2 14:02:13 INFO - PROCESS | 3386 | -------- Summary: end -------- 14:02:13 INFO - PROCESS | 3386 | 14:02:14 INFO - TEST-INFO | 3386: exit 0 14:02:14 INFO - TEST-OK | dromaeo_css | took 1112310ms 14:02:14 INFO - TEST-START | kraken 14:02:14 INFO - operating with platform_type : linux_ 14:02:14 INFO - Initialising browser for kraken test... 14:02:14 INFO - TEST-INFO | started process 3578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwehpca/profile http://localhost:56327/getInfo.html) 14:02:18 INFO - PROCESS | 3578 | __metrics Screen width/height:1600/1200 14:02:18 INFO - PROCESS | 3578 | colorDepth:24 14:02:18 INFO - PROCESS | 3578 | Browser inner width/height: 1024/697 14:02:18 INFO - PROCESS | 3578 | __metrics 14:02:19 INFO - PROCESS | 3578 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:20 INFO - TEST-INFO | 3578: exit 0 14:02:20 INFO - Browser initialized. 14:02:20 INFO - Running cycle 1/1 for kraken test... 14:02:20 INFO - TEST-INFO | started process 3668 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwehpca/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:02:32 INFO - PROCESS | 3668 | RSS: Main: 143818752 14:02:32 INFO - PROCESS | 3668 | 14:02:34 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56327/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:35 INFO - PROCESS | 3668 | RSS: Main: 177913856 14:02:35 INFO - PROCESS | 3668 | 14:02:37 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56327/tests/kraken/driver.html?testName=audio-dft) 14:02:38 INFO - PROCESS | 3668 | RSS: Main: 178008064 14:02:38 INFO - PROCESS | 3668 | 14:02:41 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56327/tests/kraken/driver.html?testName=audio-fft) 14:02:41 INFO - PROCESS | 3668 | RSS: Main: 174682112 14:02:41 INFO - PROCESS | 3668 | 14:02:43 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56327/tests/kraken/driver.html?testName=audio-oscillator) 14:02:44 INFO - PROCESS | 3668 | RSS: Main: 176766976 14:02:44 INFO - PROCESS | 3668 | 14:02:46 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:02:47 INFO - PROCESS | 3668 | RSS: Main: 173801472 14:02:47 INFO - PROCESS | 3668 | 14:02:50 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56327/tests/kraken/driver.html?testName=imaging-darkroom) 14:02:50 INFO - PROCESS | 3668 | RSS: Main: 172548096 14:02:50 INFO - PROCESS | 3668 | 14:02:54 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56327/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:54 INFO - PROCESS | 3668 | RSS: Main: 173338624 14:02:54 INFO - PROCESS | 3668 | 14:02:57 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56327/tests/kraken/driver.html?testName=json-parse-financial) 14:02:58 INFO - PROCESS | 3668 | RSS: Main: 175091712 14:02:58 INFO - PROCESS | 3668 | 14:02:59 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:00 INFO - PROCESS | 3668 | RSS: Main: 179679232 14:03:00 INFO - PROCESS | 3668 | 14:03:01 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:02 INFO - PROCESS | 3668 | RSS: Main: 175636480 14:03:02 INFO - PROCESS | 3668 | 14:03:04 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:05 INFO - PROCESS | 3668 | RSS: Main: 188719104 14:03:05 INFO - PROCESS | 3668 | 14:03:07 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:07 INFO - PROCESS | 3668 | RSS: Main: 190726144 14:03:07 INFO - PROCESS | 3668 | 14:03:10 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:11 INFO - PROCESS | 3668 | RSS: Main: 189968384 14:03:11 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | Cycle 1(1): loaded http://localhost:56327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56327/tests/kraken/driver.html?testName=ai-astar) 14:03:12 INFO - PROCESS | 3668 | RSS: Main: 251273216 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | __start_tp_report 14:03:12 INFO - PROCESS | 3668 | _x_x_mozilla_page_load 14:03:12 INFO - PROCESS | 3668 | _x_x_mozilla_page_load_details 14:03:12 INFO - PROCESS | 3668 | |i|pagename|runs| 14:03:12 INFO - PROCESS | 3668 | |0;ai-astar;111;114;106;111;110;110;100;109;109;111 14:03:12 INFO - PROCESS | 3668 | |1;audio-beat-detection;155;128;152;166;127;155;160;127;168;124 14:03:12 INFO - PROCESS | 3668 | |2;audio-dft;161;160;160;159;160;161;160;165;159;161 14:03:12 INFO - PROCESS | 3668 | |3;audio-fft;74;76;75;156;74;73;72;75;170;75 14:03:12 INFO - PROCESS | 3668 | |4;audio-oscillator;92;93;147;92;93;92;148;91;92;147 14:03:12 INFO - PROCESS | 3668 | |5;imaging-gaussian-blur;117;117;117;117;118;117;116;117;117;117 14:03:12 INFO - PROCESS | 3668 | |6;imaging-darkroom;146;145;146;145;145;145;146;146;145;146 14:03:12 INFO - PROCESS | 3668 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 14:03:12 INFO - PROCESS | 3668 | |8;json-parse-financial;54;57;55;54;55;56;55;64;54;54 14:03:12 INFO - PROCESS | 3668 | |9;json-stringify-tinderbox;64;64;65;65;65;66;65;65;66;64 14:03:12 INFO - PROCESS | 3668 | |10;stanford-crypto-aes;78;79;78;79;78;77;77;79;79;79 14:03:12 INFO - PROCESS | 3668 | |11;stanford-crypto-ccm;112;110;114;110;114;109;109;111;110;113 14:03:12 INFO - PROCESS | 3668 | |12;stanford-crypto-pbkdf2;147;151;145;142;147;138;145;147;145;151 14:03:12 INFO - PROCESS | 3668 | |13;stanford-crypto-sha256-iterative;66;68;68;66;67;65;66;67;65;65 14:03:12 INFO - PROCESS | 3668 | __end_tp_report 14:03:12 INFO - PROCESS | 3668 | __start_cc_report 14:03:12 INFO - PROCESS | 3668 | _x_x_mozilla_cycle_collect,1025 14:03:12 INFO - PROCESS | 3668 | __end_cc_report 14:03:12 INFO - PROCESS | 3668 | __startTimestamp1457647392971__endTimestamp 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | ------- Summary: start ------- 14:03:12 INFO - PROCESS | 3668 | Number of tests: 14 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.78 (3.4%) stddev-sans-first:3.95 14:03:12 INFO - PROCESS | 3668 | Values: 111.0 114.0 106.0 111.0 110.0 110.0 100.0 109.0 109.0 111.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.00 stddev:17.66 (11.4%) stddev-sans-first:18.44 14:03:12 INFO - PROCESS | 3668 | Values: 155.0 128.0 152.0 166.0 127.0 155.0 160.0 127.0 168.0 124.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.71 (1.1%) stddev-sans-first:1.81 14:03:12 INFO - PROCESS | 3668 | Values: 161.0 160.0 160.0 159.0 160.0 161.0 160.0 165.0 159.0 161.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#3] audio-fft Cycles:10 Average:92.00 Median:74.50 stddev:37.58 (50.4%) stddev-sans-first:39.29 14:03:12 INFO - PROCESS | 3668 | Values: 74.0 76.0 75.0 156.0 74.0 73.0 72.0 75.0 170.0 75.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:92.00 stddev:26.67 (29.0%) stddev-sans-first:27.59 14:03:12 INFO - PROCESS | 3668 | Values: 92.0 93.0 147.0 92.0 93.0 92.0 148.0 91.0 92.0 147.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:03:12 INFO - PROCESS | 3668 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:03:12 INFO - PROCESS | 3668 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:03:12 INFO - PROCESS | 3668 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.05 (5.5%) stddev-sans-first:3.16 14:03:12 INFO - PROCESS | 3668 | Values: 54.0 57.0 55.0 54.0 55.0 56.0 55.0 64.0 54.0 54.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:03:12 INFO - PROCESS | 3668 | Values: 64.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 64.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 14:03:12 INFO - PROCESS | 3668 | Values: 78.0 79.0 78.0 79.0 78.0 77.0 77.0 79.0 79.0 79.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#11] stanford-crypto-ccm Cycles:10 Average:111.20 Median:111.50 stddev:1.93 (1.7%) stddev-sans-first:2.03 14:03:12 INFO - PROCESS | 3668 | Values: 112.0 110.0 114.0 110.0 114.0 109.0 109.0 111.0 110.0 113.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:147.00 stddev:3.88 (2.6%) stddev-sans-first:4.09 14:03:12 INFO - PROCESS | 3668 | Values: 147.0 151.0 145.0 142.0 147.0 138.0 145.0 147.0 145.0 151.0 14:03:12 INFO - PROCESS | 3668 | 14:03:12 INFO - PROCESS | 3668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.22 14:03:12 INFO - PROCESS | 3668 | Values: 66.0 68.0 68.0 66.0 67.0 65.0 66.0 67.0 65.0 65.0 14:03:12 INFO - PROCESS | 3668 | -------- Summary: end -------- 14:03:12 INFO - PROCESS | 3668 | 14:03:13 INFO - TEST-INFO | 3668: exit 0 14:03:13 INFO - TEST-OK | kraken | took 59383ms 14:03:13 INFO - SUITE-END | took 1171s 14:03:14 INFO - Completed test suite (00:19:31) 14:03:14 INFO - javascript benchmark 14:03:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3233.6442991270965, 3257.8371081445953, 3261.755368347373, 3297.6702329767027, 3316.8009919404835, 5273.235380869772, 5287.603429742765, 5305.257263983036, 5319.388270348911, 5352.0, 5306.230596563496, 5317.149256119022, 5332.0, 5333.0, 5342.465753424655, 4852.053849499349, 4867.221244600864, 4889.022195560893, 4912.287718280847, 4912.435069966946, 4890.21756518957, 4937.679050861682, 4939.555440010398, 4941.3329200558, 4950.207966725325, 4953.356063711731, 5013.298138260647, 5022.924656130161, 5030.220315851049, 5051.747412629372, 4485.932711009337, 5027.723475208862, 5053.823116190915, 5057.291979122907, 5061.949380506203, 4843.854684359475, 4917.336159618477, 4919.72941488218, 4930.211166213388, 4955.752212389366, 5236.266922630834, 5264.947350526484, 5266.262723218714, 5271.472852714736, 5303.071962406602, 5623.8594035149035, 5698.116791897221, 5782.0, 5818.709064546798, 5833.0, 5832.620879642852, 5843.678597677126, 5867.471927526501, 5870.11948207768, 5881.382454842265, 5462.644928079662, 5468.945310546923, 5476.7535460903955, 5479.013777520045, 5486.670799751988, 5736.713164341766, 5923.259592550931, 6007.8197654070445, 6009.308929473166, 6026.608270462406, 5728.51307638847, 5753.223314852441, 5753.510951569164, 5754.712264386764, 5765.04876695349, 5828.358880523139, 5841.269841269841, 5846.152307915413, 5854.677992710356, 5858.707064646751, 5571.331440227118, 5704.857378565569, 5753.223314852525, 5757.366689664133, 5759.596828221985, 5751.252337196222, 5752.36723960364, 5761.683107429131, 5764.164196191613, 5766.135079738073, 4282.678799090018, 4406.691531592822, 4407.713498622579, 4410.236521929343, 4436.3123715824095, 3941.1132495188353, 3991.7604943703473, 4004.799760011988, 4011.458453108793, 4035.414864844581, 5438.564914806806, 5445.482679145475, 5447.046766815792, 5457.590680698963, 5461.2354270402175, 5746.0519014363, 5824.970875145597, 5847.386024467455, 5847.473727364558, 5851.64890106595, 5427.972860135674, 5440.700761458158, 5451.918221226685, 5460.399356070829, 5500.532454741392, 4957.876053098629, 4963.45402005779, 4963.851084467472, 4968.403791545038, 4999.325091112726, 5782.826515204551, 5995.46040856325, 6013.248343957005, 6014.578979471395, 6078.574499784972, 5883.176355310346, 5885.499732522783, 5921.911171332519, 5922.2597175353085, 5924.733386997509, 5954.136650185786, 6022.7289771959495, 6057.515398768, 6061.6666083365835, 6072.240969878765, 5599.692016939108, 5659.971700141473, 5725.570582206268, 5765.135229715576, 5780.682062486603, 5867.178594996619, 5884.382139875423, 5887.264091988502, 5887.322957859729, 5889.94110058894, 5692.459216374438, 5717.22817419643, 5718.885622287614, 5718.942810571841, 5747.281589801275, 5511.641743286834, 5713.428657134419, 5736.569757268138, 5786.797462088806, 5814.563907707024, 5669.404712505293, 5683.23276357703, 5694.829155125353, 5700.942990570207, 5726.513246374105, 5599.188117722989, 5780.508656764222, 5794.913076303775, 5800.883982320414, 5810.389909059657, 5410.918836217538, 5489.560835133259, 5559.0827513461445, 5608.495235428831, 5614.7192640367], "unit": "score", "name": "dojo.html", "value": 5353.447907446014}, {"lowerIsBetter": false, "replicates": [526.3815017354608, 542.0541155683334, 553.6014069869694, 558.3997203006769, 572.8224250482353, 31672.366552668962, 38707.61292387075, 39222.21555568887, 39242.80378598103, 39301.80349098251, 46270.0, 46890.29664555034, 47021.0, 47022.52977470224, 47061.52938470614, 8899.599518021689, 9193.494357810318, 9198.724038278862, 9199.264058875275, 9200.723978280663, 8883.689070882521, 9007.774805629846, 9023.142801433853, 9033.0, 9035.503047332393, 9000.099990001014, 9040.954795226015, 9086.727398178065, 9087.363884528086, 9089.409188402766, 8944.373893827402, 9017.233535149455, 9023.4134781239, 9034.774130646721, 9035.141661542177, 9005.684801031932, 9126.908730912672, 9129.041450647654, 9139.497327646977, 9145.085491450802, 42356.0, 42688.57311426877, 42713.145737085084, 42800.143997119885, 42830.57169428297, 3742.270257299828, 3830.559485659157, 3981.6018398159954, 4225.746455212667, 4256.5105012923605, 33813.0, 33937.49093763596, 34150.82924585386, 34163.487547686804, 34423.48364774531, 3887.319719049155, 3924.4701965234613, 3944.3294639911283, 4011.4785077939973, 4217.072244106292, 227432.0, 229320.0, 229940.0, 230698.0, 231303.9999999983, 59116.0, 59810.0, 59945.0, 59986.400135998956, 65317.346826531124, 76593.6170319156, 77085.0, 77581.22418775853, 77653.0, 77747.0, 15581.844181558039, 15841.920790395974, 15897.443589474544, 15931.12378819176, 15932.522024339289, 11872.0, 11884.465199066062, 11898.643040708792, 11907.166498345032, 11931.343776092224, 22508.54982900333, 22829.543409132057, 22851.0, 22893.885530572574, 22909.770902290762, 7968.920310796818, 8250.793730156794, 8259.876101858477, 8317.542535160625, 8449.112843151504, 991.251605038206, 1038.771470276538, 1045.2160879340495, 1050.5902697947806, 1142.5486932661718, 29912.85043574768, 30058.24854378658, 30364.54453183204, 30838.845805770827, 30856.69143308583, 1109.3953795181646, 1131.4060118437885, 1146.644540192543, 1157.9536818527333, 1206.831043653889, 15799.526014219591, 15928.76106858398, 16099.758503622455, 16135.193240337936, 16316.265768040466, 340385.0, 344004.0, 344915.0, 344953.0, 345197.0, 55327.44672553303, 55727.0, 56395.0, 56459.0, 56568.0, 1227.5642147037672, 1350.0, 1436.655202751353, 1464.9560513184622, 1464.978025329621, 28521.42957140887, 29883.850580746956, 29894.551581725857, 30192.396152076395, 30625.23436914095, 43709.78145109254, 44533.0, 45518.0, 45663.0, 45710.77144614256, 238453.0, 239339.0, 240094.0, 240287.0, 282682.0, 34003.319933600695, 34183.82908085443, 34654.82672586621, 34793.47809782906, 35144.297114057066, 41354.586454135075, 42210.36684449674, 50294.748526257135, 52745.20882186847, 53062.46937530575, 36929.26141477209, 37133.25733485261, 37227.255454891296, 37327.0, 37372.439413408276, 39487.407688884115, 40062.599374007055, 40245.79877100713, 40353.0, 40771.796141019106, 39803.0, 39861.2027759449, 40249.19501609893, 40659.186816264104, 40833.18333633251, 35787.64212357947, 36542.0, 37249.44125838169, 37274.813625931696, 37316.0, 27949.580756288266, 28841.567376489787, 28903.828589395504, 28956.42087158287, 29156.7084329154], "unit": "score", "name": "ext.html", "value": 19539.657621728224}, {"lowerIsBetter": false, "replicates": [376.87374729465637, 378.8522476234269, 390.52161102649256, 394.86574564648015, 397.5289282200591, 17675.078645218262, 19401.902990485047, 19842.710223835442, 19947.50131246718, 19990.50023749407, 17955.0, 18171.182296796644, 18398.816011839877, 18539.629207415845, 18554.53613659659, 5681.7727290908315, 5835.912461313083, 5840.240768700063, 5870.941290587103, 5877.85305367365, 4339.500957389893, 6274.968625156891, 6557.409833115019, 6587.7364905403965, 6590.373914478141, 6446.677666116699, 6505.902411463831, 6531.771388001421, 6563.0, 6566.1464009678675, 6314.905276420857, 6461.5153863459955, 6477.093206951031, 6484.805455836309, 6504.577202481847, 3931.8820435386983, 4086.3053280942013, 5471.50756431919, 5689.175069614883, 5689.687067211302, 12808.231506109663, 13399.799003014963, 13414.0, 22129.44676383087, 22131.0, 2250.5161390301, 2295.0934380919443, 2340.941476463085, 2426.4419183587697, 2877.949548414834, 9288.442693438416, 9952.950235248778, 9978.800423991479, 10258.846117308247, 10586.41774702391, 1921.990390048055, 1955.2765476773543, 1958.921643134273, 1989.5821877405617, 2021.0299056452839, 67929.98105028429, 68304.6584767078, 68572.3142768571, 68677.3132268676, 68872.655636722, 10580.407800089028, 10683.0, 10803.891961080446, 11047.779044419227, 11262.887371126184, 14986.47547335838, 15003.399864005536, 15034.398624054915, 15043.323050462755, 15047.247637618295, 7527.510711803715, 7596.088469383599, 7745.922540774633, 7841.5687137208, 8007.959960200162, 6379.872402552016, 6438.77464288757, 6475.4819614430735, 7007.054047703597, 7198.928010719826, 4369.694121411534, 4794.7842347093765, 4860.3195552621955, 4902.7058376497525, 4968.22992436173, 1582.0507695382908, 1617.6198593330557, 1674.2382216091648, 1732.3070771691173, 1779.350537053992, 962.0, 963.9710808675751, 986.5609803637312, 1004.487711267259, 1026.5072765072807, 15960.600984975235, 16888.83111168897, 17619.735703964452, 18024.639507209784, 18122.546936326435, 984.1142971325721, 1028.7942411517727, 1034.374203606822, 1046.0219694585587, 1052.4211683574003, 9822.263330250116, 9993.450360230258, 10104.09063184317, 10164.898351016544, 10291.53688084038, 462868.0, 481502.0, 486465.0, 490312.0, 491836.0, 62500.68749656223, 78806.0, 81416.59291703504, 81702.0, 81994.18005819866, 1039.6413237433073, 1050.0444595418132, 1051.374432212832, 1063.9787204255872, 1064.3135177810268, 15594.0, 15606.9219653901, 15834.841651583798, 15879.68240635204, 16041.598960026093, 33322.333553329285, 34348.31303373969, 34671.0, 35409.46885796663, 35506.46740298846, 42261.788691057576, 44562.77718611386, 45455.31817022681, 45780.542194577625, 47314.763426182646, 7501.137369202612, 7804.726834560764, 7867.331276841533, 7962.800929976797, 8213.0, 9335.0, 10640.52117654692, 12813.167144135601, 12969.935150324189, 12987.41556629935, 8946.910530894607, 10014.0, 10683.30558513694, 11686.415679216176, 11801.881981180079, 11739.941300293785, 11766.117541184274, 12080.03359731237, 12140.39298035077, 12145.210561313486, 12139.39303034827, 12212.633620991384, 12223.44994475233, 12225.633231003085, 12284.38578071075, 8166.550839703873, 8273.46222495536, 8426.747197584082, 8434.620442079999, 8575.356848236283, 10350.896491034993, 12106.213096148722, 12147.57483488109, 12277.324747138993, 12365.0], "unit": "score", "name": "jquery.html", "value": 8784.898149635268}, {"lowerIsBetter": false, "replicates": [1449.9565013049598, 1567.6159340961462, 1580.5495433801366, 1815.292036105919, 1929.488685498343, 7996.320312773414, 8328.042275138361, 8349.95825020874, 8354.456960297577, 8383.371247156458, 8185.836283274346, 8310.95844520778, 8325.417220794547, 8336.0, 8343.833123337545, 2146.6887301341294, 2202.2622421488823, 2448.0, 2453.1904471524444, 2486.11742831295, 2484.6024636058232, 2489.0, 2497.900083996638, 2500.9374765630914, 2501.049601151569, 2401.1835975768236, 2420.987895060522, 2451.656768052474, 2469.1481438903547, 2471.085698291635, 2436.84160529565, 2455.5579995600783, 2466.235467005225, 2466.8889899954547, 2487.0549191307186, 2457.2751038443703, 2461.716902556211, 2476.4675594747036, 2484.3043947694673, 2491.202815099169, 8533.274671652916, 8584.27033702136, 8589.312854971588, 8590.140985901422, 8591.785205369853, 5204.34945631796, 5321.893562128775, 5328.866778330534, 5331.253624492574, 5333.786648534054, 3368.831558422069, 3373.3759254537745, 3434.639362866913, 3439.6216416194197, 3501.9474707879403, 1042.968710938673, 1081.313151483688, 1086.3536195963388, 1108.539955918293, 1110.722319420145, 12247.387630618523, 12260.386980651021, 12269.509219631203, 12281.385930703518, 12292.877071229263, 4743.833965811249, 4769.475357710649, 4817.0365926814775, 4841.636877234151, 4861.076395484846, 10001.0, 10055.145312648361, 10067.194624430029, 10069.597216111273, 10085.747856303504, 5259.868503287372, 5279.313689220454, 5289.788408463618, 5303.36359636846, 5306.575473962073, 4188.204241194163, 4322.308430651081, 4720.929186062212, 4764.523547645208, 4783.425988881357, 3945.2109578084496, 4011.7592944423427, 4022.9798851005557, 4049.716519843583, 4083.9183216335505, 1248.2448118888124, 1255.535451882791, 1255.8806913343217, 1262.501311981762, 1264.8292480515197, 1186.8694443611196, 1188.3167178872184, 1207.034372501995, 1438.439008786574, 1502.346479281516, 8189.262966333059, 8232.62953167109, 8327.916720832834, 8342.916570834213, 8344.41589088758, 522.7804322184692, 524.8950209957948, 526.2422112158556, 528.9603279754034, 536.4421002157791, 5936.762529498858, 5999.190109335271, 6012.278526576752, 6052.182955300978, 6063.090536419572, 9983.900160998297, 10012.499375031219, 10145.797084058426, 10166.745831354276, 10181.490925453698, 9845.50772461374, 9962.103410693073, 9995.300328976902, 9998.300118991601, 10015.148712359385, 7945.165757595485, 8051.879221811678, 8054.879176812353, 8094.3929205311015, 8150.266476017068, 7814.4529882907655, 7918.2477664621765, 7977.441579089408, 8081.757547273592, 8097.190280971856, 9262.768430789285, 9285.396449230779, 9362.485063321583, 9363.672271470467, 9463.337566370288, 9316.860247096434, 9527.523623818919, 9701.175400091071, 9705.12653861156, 9712.223022158352, 6637.336266373324, 7202.0, 7381.446391520765, 7444.404447644067, 7512.39900807945, 8047.597620118853, 8049.959750201211, 8050.959745201237, 8065.435419520577, 8092.069412017693, 7106.5736055836815, 7288.817779555554, 7368.963155184404, 7507.061617297838, 7510.474266801271, 7240.384567311627, 7320.194778574459, 7377.5204611700065, 7514.098308203051, 7594.544327340377, 7928.167542408195, 7938.087119981276, 7987.241212084843, 7996.280334769898, 7997.440179187401, 7244.058272424551, 7297.63511824396, 7342.6695798688115, 7390.5196162249285, 7396.223396543501, 7356.4114870809135, 7377.631118443949, 7405.703771849066, 7436.070491188601, 7442.4418168636485], "unit": "score", "name": "mootools.html", "value": 4800.415663387795}, {"lowerIsBetter": false, "replicates": [329.5320644684548, 334.88111720339293, 335.73644688919205, 338.61567121317313, 340.4467739922626, 6046.062860256662, 6047.0, 6077.02767557191, 6084.239470066236, 6107.2976607690125, 5992.34084250732, 6002.339742628307, 6006.57953943223, 6015.6992150392525, 6021.578489505737, 4483.955160448387, 4521.502634710179, 4575.062112266994, 4642.396488456496, 4674.415698037746, 4634.281686338606, 4653.325267836161, 4661.813527458898, 4662.347271382009, 4662.953370466303, 4610.97694511527, 4617.699849509788, 4620.468646105691, 4621.491635920046, 4637.0, 4464.397306363632, 4523.864284071483, 4617.30740388941, 4618.237990731525, 4645.0477652081245, 4035.0, 4051.8379264829373, 4054.1891621675486, 4062.614051665087, 4073.816678249486, 5751.511121554673, 5751.654900705929, 5762.279715035621, 5767.5962682612235, 5772.30732312121, 5385.730713464351, 5390.703511306916, 5396.298481197419, 5397.676139431646, 5403.7027963462, 6372.2671892732005, 6404.743810247584, 6408.198975128109, 6409.743610255584, 6411.262704788963, 4320.200762858881, 4460.1525710114975, 4460.15257101153, 4462.3752674625575, 4496.3705081288645, 6652.966735166293, 6702.620569697785, 6706.128203333536, 6716.597004179716, 6718.328167183291, 4587.243104887723, 4587.288970209623, 4587.770611469413, 4589.79345929434, 4598.517155698671, 4651.906961860744, 4653.418322709661, 4653.7207767534055, 4655.4878963314, 4656.301554766812, 5368.489993450616, 5376.005438993799, 5381.192821076792, 5387.784488620489, 5387.784488620489, 6329.905051424233, 6462.709178086998, 6470.352964703586, 6479.902801457982, 6488.929326661142, 1594.067470529753, 1599.4561848971405, 1607.5177446766156, 1607.734723770588, 1608.340580362046, 988.110700369673, 1059.7191744187796, 1068.3750006246278, 1084.9349039057681, 1085.766560189563, 6113.083037544404, 6123.203983482119, 6162.876742465126, 6177.62934223948, 6178.135061091451, 6658.0, 6658.03458498515, 6660.467162626978, 6666.166729158856, 6668.166479190101, 6176.073588961602, 6176.845578860474, 6180.536459765535, 6183.319834818167, 6193.783217587453, 3559.14580500678, 3559.60844307126, 3561.5013898054294, 3569.3396721606587, 3592.191756854739, 6651.135352404156, 6813.386795188457, 6876.69054892521, 6880.862382752317, 6883.449324054063, 6664.333566643297, 6728.932710672929, 6751.358620931003, 6770.932290677129, 6778.118844550276, 6779.5254332197255, 6797.932020679828, 6830.872905970459, 6844.8973265401055, 6846.486513511507, 6635.435987940886, 6639.336066393322, 6649.0, 6654.767083152066, 6654.933450665431, 6402.423781859655, 6533.738650454119, 6544.116544266463, 6551.213854337319, 6551.737930482727, 6800.31996800316, 6822.351876571718, 6844.0, 6844.657767111724, 6852.691628876612, 4561.817527298871, 4567.132244873464, 4571.657125715518, 4572.565606267399, 4573.199690054294, 6641.1034510342415, 6644.7009884554345, 6648.933510664831, 6649.035889795856, 6651.667416629246, 6286.245650521967, 6481.740730370921, 6516.967415162894, 6526.053722210158, 6546.214454265519, 6418.93581064202, 6421.935780642134, 6457.354264573505, 6462.386073323027, 6465.321141280097, 6311.0, 6321.5258855586935, 6322.114903913363, 6323.241211054519, 6343.619382837044, 6444.45222156122, 6454.741810327534, 6466.450351719968, 6467.967660161858, 6468.062130991074, 6167.938320616916, 6226.12834203221, 6267.811965641038, 6274.968625156845, 6306.779262725782], "unit": "score", "name": "prototype.html", "value": 4840.4635679093235}, {"lowerIsBetter": false, "replicates": [780.6643143448317, 794.614611913222, 818.1000899011085, 833.2209384225753, 905.8414777413951, 15922.601934951632, 16056.357745690158, 16059.437919672813, 16090.839091609081, 16147.111908845009, 15101.697966040672, 15243.31405086771, 15331.463398781045, 15349.462768803094, 15356.923215383935, 776.6543887969856, 915.5147771680986, 915.7527467583749, 929.9395539289925, 935.088288918306, 930.6044930904372, 936.967206147785, 940.9717708468756, 941.7692665297012, 942.189716843514, 980.5685498380725, 981.9754506137332, 983.1102851918989, 985.8422652375622, 986.0435377683672, 807.3944541593804, 961.8941916389192, 979.9804003919882, 983.572146116438, 986.2011770465874, 718.3175982816293, 718.5006420537728, 718.881384571545, 719.3058698356111, 719.6761457344217, 12749.490020399173, 12796.61610151697, 12858.357082145856, 12922.095453318272, 12957.740845183138, 12659.0, 12773.233605983578, 12821.67945801353, 13014.47942082325, 13044.217346959213, 10911.399873006982, 11044.558217671363, 11052.502637381338, 11164.218504704673, 12101.757964840654, 3574.6246644102257, 3604.2611264690677, 3623.0942264433893, 3626.4560315952554, 3855.8843234703004, 56822.0, 56896.71551642257, 57222.42777572213, 57379.42620573783, 57469.13796293059, 9340.4862732549, 9423.623055077856, 9458.716238512856, 9649.276304277208, 10373.118284945864, 18569.628607428047, 18582.0, 18617.510599152036, 18736.15687294048, 18748.906255468635, 7475.439342049368, 7558.281963213486, 7622.237776222333, 7980.241877021674, 8031.036275646959, 4294.871153865389, 4359.237133501624, 4365.192439398658, 4374.846880359172, 4400.405945197357, 3454.1882657575447, 3460.048486666187, 3464.965350346464, 3469.479578063311, 3471.8437670304897, 589.8731772668897, 593.4243783529969, 630.4830039367766, 646.0599827251338, 684.3635419060222, 583.6789765628887, 630.3444417805523, 648.4650163615037, 649.5453182772078, 658.3219284137347, 8811.206991370807, 8917.866232006525, 8989.325800564984, 9054.81890362189, 9269.536523173949, 661.6493258572964, 676.3067855448106, 678.4402867634221, 679.6228093408107, 692.4322055914103, 4019.2765302245293, 4225.535191128974, 4286.678499112579, 4346.673999450054, 4373.147236288957, 58242.0, 59292.40707592955, 60709.0, 61057.389426106056, 61544.69227653833, 51615.0, 51622.48377516252, 52846.735766320926, 53622.0, 54293.0, 46902.0, 47490.28764568534, 47545.286820697715, 47926.76036619864, 48449.75775121102, 9271.490068046052, 9389.0, 9443.575039123394, 9457.810843783223, 9597.808043839224, 35577.0, 36064.27871442609, 36798.0, 37170.0, 37795.81102094472, 46138.0, 47425.52574474349, 47785.04429911452, 47980.04039919112, 48235.517644824504, 11722.413879306172, 11731.120165987755, 11783.0, 11783.410829458322, 11800.52797888075, 13376.732465350833, 13474.730505390033, 13547.390367433292, 13615.931920340336, 13887.58337249884, 11365.261258018203, 11488.0, 11568.652940411801, 11581.975643567388, 12214.0, 11915.406290761157, 12019.63941081769, 12085.335306558223, 12285.631431057083, 12375.195612285173, 11912.702182445162, 12063.155579109378, 12209.328486932949, 12232.327222002876, 12450.626481205578, 9711.5144242789, 9724.319297649097, 9827.164691001344, 10020.198384129399, 10037.69886903394, 10450.372977621062, 10573.207009474167, 10611.681649550526, 10669.46652667348, 10752.247342686249], "unit": "score", "name": "yui.html", "value": 6744.131485723948}], "name": "dromaeo_css", "value": 7239.958722352536}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 111.0, 110.0, 110.0, 100.0, 109.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [155.0, 128.0, 152.0, 166.0, 127.0, 155.0, 160.0, 127.0, 168.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 159.0, 160.0, 161.0, 160.0, 165.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 75.0, 156.0, 74.0, 73.0, 72.0, 75.0, 170.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 147.0, 92.0, 93.0, 92.0, 148.0, 91.0, 92.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 54.0, 55.0, 56.0, 55.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 78.0, 79.0, 78.0, 77.0, 77.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [112.0, 110.0, 114.0, 110.0, 114.0, 109.0, 109.0, 111.0, 110.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.2}, {"lowerIsBetter": true, "replicates": [147.0, 151.0, 145.0, 142.0, 147.0, 138.0, 145.0, 147.0, 145.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 68.0, 66.0, 67.0, 65.0, 66.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1496.5}]} 14:03:14 INFO - Return code: 0 14:03:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:03:14 INFO - # TBPL SUCCESS # 14:03:14 INFO - Running post-action listener: _resource_record_post_action 14:03:14 INFO - Running post-run listener: _resource_record_post_run 14:03:15 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 7806976; Write bytes: 380698624; Read time: 1284; Write time: 399240 14:03:15 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4685824; Read time: 0; Write time: 356 14:03:15 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6045696; Write bytes: 376012800; Read time: 1204; Write time: 398884 14:03:15 INFO - Running post-run listener: _upload_blobber_files 14:03:15 INFO - Blob upload gear active. 14:03:15 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:03:15 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:03:15 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:03:15 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:03:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:16 INFO - (blobuploader) - INFO - Done attempting. 14:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:03:17 INFO - (blobuploader) - INFO - Done attempting. 14:03:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:03:17 INFO - Return code: 0 14:03:17 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:03:17 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:03:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9103994978a4544e95fd87e7e4418980aabe01a2a5a642e3b14a47fedb2ac20b2938dd837425b7bf18851108b93b9d6abdd9c546b11ee9e6536f8aee9777d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc51a278e7fc59aadecf1de61a5d19d64e5ba49e164bae41726375a82d815207f9e5445b9b75a26ba9f0410e7dd238fbaa3ace04200ba3c87498816ad4d2e27"} 14:03:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:03:17 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:03:17 INFO - Contents: 14:03:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9103994978a4544e95fd87e7e4418980aabe01a2a5a642e3b14a47fedb2ac20b2938dd837425b7bf18851108b93b9d6abdd9c546b11ee9e6536f8aee9777d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc51a278e7fc59aadecf1de61a5d19d64e5ba49e164bae41726375a82d815207f9e5445b9b75a26ba9f0410e7dd238fbaa3ace04200ba3c87498816ad4d2e27"} 14:03:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:03:17 INFO - Copying logs to upload dir... 14:03:17 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:03:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.229515 ========= master_lag: 31.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-03-10 14:03:49.127310) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 14:03:49.130419) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 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-Aurora/sha512/f9103994978a4544e95fd87e7e4418980aabe01a2a5a642e3b14a47fedb2ac20b2938dd837425b7bf18851108b93b9d6abdd9c546b11ee9e6536f8aee9777d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc51a278e7fc59aadecf1de61a5d19d64e5ba49e164bae41726375a82d815207f9e5445b9b75a26ba9f0410e7dd238fbaa3ace04200ba3c87498816ad4d2e27"} build_url:https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/SL3mZMWBQGKfRPOFBMm7yw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f9103994978a4544e95fd87e7e4418980aabe01a2a5a642e3b14a47fedb2ac20b2938dd837425b7bf18851108b93b9d6abdd9c546b11ee9e6536f8aee9777d97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cc51a278e7fc59aadecf1de61a5d19d64e5ba49e164bae41726375a82d815207f9e5445b9b75a26ba9f0410e7dd238fbaa3ace04200ba3c87498816ad4d2e27"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 14:03:49.438881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 14:03:49.439233) ========= 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=62c568580acbfdaac3eec7be000001dc-1457645131.697318-606028287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 14:03:49.458006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 14:03:49.458323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-10 14:03:49.458604) ========= ========= Total master_lag: 31.89 =========