builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1458731274.93 results: success (0) buildid: 20160323013058 builduid: 2d9469554c694d4285a54f4665c9152d revision: 8786bbb9702f808a01ae45a5153440a7c44699fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:54.933137) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:54.933556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:54.933850) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006509 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:54.977839) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:54.978113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.036094) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.036371) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.087260) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.087578) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.087948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.088229) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 04:07:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-03-23 04:07:55 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.283436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.283723) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014359 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.333459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.333794) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8786bbb9702f808a01ae45a5153440a7c44699fb --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8786bbb9702f808a01ae45a5153440a7c44699fb --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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 04:07:55,919 truncating revision to first 12 chars 2016-03-23 04:07:55,919 Setting DEBUG logging. 2016-03-23 04:07:55,919 attempt 1/10 2016-03-23 04:07:55,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8786bbb9702f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 04:07:56,150 unpacking tar archive at: mozilla-inbound-8786bbb9702f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.491853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.840446) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.840785) ========= echo 8786bbb9702f808a01ae45a5153440a7c44699fb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8786bbb9702f808a01ae45a5153440a7c44699fb'] 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8786bbb9702f808a01ae45a5153440a7c44699fb program finished with exit code 0 elapsedTime=0.004835 script_repo_revision: '8786bbb9702f808a01ae45a5153440a7c44699fb' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.890055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.890391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:07:55.900874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-03-23 04:07:55.901267) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:56 INFO - MultiFileLogger online at 20160323 04:07:56 in /builds/slave/test-pgo 04:07:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:07:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:07:56 INFO - {'append_to_log': False, 04:07:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:07:56 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:07:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:07:56 INFO - 'branch': 'Mozilla-Inbound', 04:07:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:56 INFO - 'config_files': ('talos/linux_config.py',), 04:07:56 INFO - 'default_actions': ('clobber', 04:07:56 INFO - 'read-buildbot-config', 04:07:56 INFO - 'download-and-extract', 04:07:56 INFO - 'populate-webroot', 04:07:56 INFO - 'create-virtualenv', 04:07:56 INFO - 'install', 04:07:56 INFO - 'run-tests'), 04:07:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:56 INFO - 'download_minidump_stackwalk': True, 04:07:56 INFO - 'download_symbols': 'ondemand', 04:07:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:56 INFO - 'installer_path': 'installer.exe', 04:07:56 INFO - 'log_level': 'info', 04:07:56 INFO - 'log_name': 'talos', 04:07:56 INFO - 'log_to_console': True, 04:07:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:56 INFO - 'opt_config_files': (), 04:07:56 INFO - 'pip_index': False, 04:07:56 INFO - 'sps_profile': False, 04:07:56 INFO - 'sps_profile_interval': 0, 04:07:56 INFO - 'suite': 'dromaeojs', 04:07:56 INFO - 'system_bits': '32', 04:07:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:56 INFO - 'title': 'talos-linux64-ix-005', 04:07:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:56 INFO - 'use_talos_json': True, 04:07:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:07:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:56 INFO - 'work_dir': 'build'} 04:07:56 INFO - ##### 04:07:56 INFO - ##### Running clobber step. 04:07:56 INFO - ##### 04:07:56 INFO - Running pre-action listener: _resource_record_pre_action 04:07:56 INFO - Running main action method: clobber 04:07:56 INFO - rmtree: /builds/slave/test-pgo/build 04:07:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:07:57 INFO - Running post-action listener: _resource_record_post_action 04:07:57 INFO - ##### 04:07:57 INFO - ##### Running read-buildbot-config step. 04:07:57 INFO - ##### 04:07:57 INFO - Running pre-action listener: _resource_record_pre_action 04:07:57 INFO - Running main action method: read_buildbot_config 04:07:57 INFO - Using buildbot properties: 04:07:57 INFO - { 04:07:57 INFO - "project": "", 04:07:57 INFO - "product": "firefox", 04:07:57 INFO - "script_repo_revision": "production", 04:07:57 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:07:57 INFO - "repository": "", 04:07:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:07:57 INFO - "buildid": "20160323013058", 04:07:57 INFO - "pgo_build": "True", 04:07:57 INFO - "basedir": "/builds/slave/test-pgo", 04:07:57 INFO - "buildnumber": 820, 04:07:57 INFO - "slavename": "talos-linux64-ix-005", 04:07:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:07:57 INFO - "platform": "ubuntu64_hw", 04:07:57 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:07:57 INFO - "branch": "mozilla-inbound", 04:07:57 INFO - "repo_path": "integration/mozilla-inbound", 04:07:57 INFO - "revision": "8786bbb9702f808a01ae45a5153440a7c44699fb", 04:07:57 INFO - "stage_platform": "linux64-pgo", 04:07:57 INFO - "builduid": "2d9469554c694d4285a54f4665c9152d", 04:07:57 INFO - "slavebuilddir": "test" 04:07:57 INFO - } 04:07:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:07:57 INFO - Running post-action listener: _resource_record_post_action 04:07:57 INFO - ##### 04:07:57 INFO - ##### Running download-and-extract step. 04:07:57 INFO - ##### 04:07:57 INFO - Running pre-action listener: _resource_record_pre_action 04:07:57 INFO - Running main action method: download_and_extract 04:07:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:57 INFO - https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:07:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:07:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:07:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:08:07 INFO - Downloaded 1361 bytes. 04:08:07 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:08:07 INFO - Using the following test package requirements: 04:08:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:08:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'jsshell-linux-x86_64.zip'], 04:08:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:07 INFO - https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:22 INFO - Downloaded 23597022 bytes. 04:08:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:08:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:08:23 INFO - Return code: 0 04:08:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:23 INFO - https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:24 INFO - Downloaded 23597022 bytes. 04:08:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:08:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:08:26 INFO - Return code: 0 04:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:26 INFO - https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:08:27 INFO - Downloaded 10846780 bytes. 04:08:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:08:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:08:27 INFO - Return code: 0 04:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:27 INFO - https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:08:31 INFO - Downloaded 57726439 bytes. 04:08:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:31 INFO - mkdir: /builds/slave/test-pgo/properties 04:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Contents: 04:08:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:33 INFO - Running post-action listener: _resource_record_post_action 04:08:33 INFO - Running post-action listener: set_extra_try_arguments 04:08:33 INFO - ##### 04:08:33 INFO - ##### Running populate-webroot step. 04:08:33 INFO - ##### 04:08:33 INFO - Running pre-action listener: _resource_record_pre_action 04:08:33 INFO - Running main action method: populate_webroot 04:08:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:33 INFO - '--tppagecycles', 04:08:33 INFO - '7'], 04:08:33 INFO - 'tests': ['tsvgm']}}, 04:08:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:08:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['damp', 'tps']}, 04:08:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['damp', 'tps']}, 04:08:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:33 INFO - 'other': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other_l64': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:33 INFO - 'ts_paint', 04:08:33 INFO - 'tpaint', 04:08:33 INFO - 'sessionrestore', 04:08:33 INFO - 'sessionrestore_no_auto_restore', 04:08:33 INFO - 'tabpaint']}, 04:08:33 INFO - 'svgr': {'tests': ['tsvgx', 04:08:33 INFO - 'tsvgr_opacity', 04:08:33 INFO - 'tart', 04:08:33 INFO - 'tscrollx', 04:08:33 INFO - 'cart']}, 04:08:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['tsvgx', 04:08:33 INFO - 'tsvgr_opacity', 04:08:33 INFO - 'tart', 04:08:33 INFO - 'tscrollx', 04:08:33 INFO - 'cart']}, 04:08:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'tests': ['tp5o']}, 04:08:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--e10s'], 04:08:33 INFO - 'tests': ['tp5o']}, 04:08:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--xperf_path', 04:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:33 INFO - 'tests': ['tp5n']}, 04:08:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:33 INFO - 'talos_options': ['--e10s', 04:08:33 INFO - '--xperf_path', 04:08:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:33 INFO - 'tests': ['tp5n']}}, 04:08:33 INFO - 'talos.zip': {'path': '', 04:08:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:33 INFO - Running post-action listener: _resource_record_post_action 04:08:33 INFO - ##### 04:08:33 INFO - ##### Running create-virtualenv step. 04:08:33 INFO - ##### 04:08:33 INFO - Running pre-action listener: _resource_record_pre_action 04:08:33 INFO - Running main action method: create_virtualenv 04:08:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:08:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:08:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:08:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:33 INFO - Using real prefix '/usr' 04:08:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:08:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:35 INFO - Installing pip.................done. 04:08:35 INFO - Return code: 0 04:08:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:08:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:08:35 INFO - Using env: {'DISPLAY': ':0', 04:08:35 INFO - 'HOME': '/home/cltbld', 04:08:35 INFO - 'LANG': 'en_US.UTF-8', 04:08:35 INFO - 'LANGUAGE': 'en_US:en', 04:08:35 INFO - 'LOGNAME': 'cltbld', 04:08:35 INFO - 'MAIL': '/var/mail/cltbld', 04:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:35 INFO - 'MOZ_NO_REMOTE': '1', 04:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:35 INFO - 'NO_EM_RESTART': '1', 04:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:35 INFO - 'SHELL': '/bin/bash', 04:08:35 INFO - 'SHLVL': '1', 04:08:35 INFO - 'TERM': 'linux', 04:08:35 INFO - 'TMOUT': '86400', 04:08:35 INFO - 'USER': 'cltbld', 04:08:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:35 INFO - '_': '/tools/buildbot/bin/python'} 04:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:08:35 INFO - Cleaning up... 04:08:35 INFO - Return code: 0 04:08:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:35 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:08:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:08:35 INFO - Using env: {'DISPLAY': ':0', 04:08:35 INFO - 'HOME': '/home/cltbld', 04:08:35 INFO - 'LANG': 'en_US.UTF-8', 04:08:35 INFO - 'LANGUAGE': 'en_US:en', 04:08:35 INFO - 'LOGNAME': 'cltbld', 04:08:35 INFO - 'MAIL': '/var/mail/cltbld', 04:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:35 INFO - 'MOZ_NO_REMOTE': '1', 04:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:35 INFO - 'NO_EM_RESTART': '1', 04:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:35 INFO - 'SHELL': '/bin/bash', 04:08:35 INFO - 'SHLVL': '1', 04:08:35 INFO - 'TERM': 'linux', 04:08:35 INFO - 'TMOUT': '86400', 04:08:35 INFO - 'USER': 'cltbld', 04:08:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:35 INFO - '_': '/tools/buildbot/bin/python'} 04:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:36 INFO - Downloading/unpacking psutil>=0.7.1 04:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:37 INFO - Installing collected packages: psutil 04:08:37 INFO - Running setup.py install for psutil 04:08:38 INFO - building 'psutil._psutil_linux' extension 04:08:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:08:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:08:38 INFO - building 'psutil._psutil_posix' extension 04:08:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:08:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:08:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:38 INFO - Successfully installed psutil 04:08:38 INFO - Cleaning up... 04:08:38 INFO - Return code: 0 04:08:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:08:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:08:38 INFO - Using env: {'DISPLAY': ':0', 04:08:38 INFO - 'HOME': '/home/cltbld', 04:08:38 INFO - 'LANG': 'en_US.UTF-8', 04:08:38 INFO - 'LANGUAGE': 'en_US:en', 04:08:38 INFO - 'LOGNAME': 'cltbld', 04:08:38 INFO - 'MAIL': '/var/mail/cltbld', 04:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:38 INFO - 'MOZ_NO_REMOTE': '1', 04:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:38 INFO - 'NO_EM_RESTART': '1', 04:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:38 INFO - 'SHELL': '/bin/bash', 04:08:38 INFO - 'SHLVL': '1', 04:08:38 INFO - 'TERM': 'linux', 04:08:38 INFO - 'TMOUT': '86400', 04:08:38 INFO - 'USER': 'cltbld', 04:08:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:38 INFO - '_': '/tools/buildbot/bin/python'} 04:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:40 INFO - Installing collected packages: mozsystemmonitor 04:08:40 INFO - Running setup.py install for mozsystemmonitor 04:08:40 INFO - Successfully installed mozsystemmonitor 04:08:40 INFO - Cleaning up... 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:08: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')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:08:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:08:40 INFO - Using env: {'DISPLAY': ':0', 04:08:40 INFO - 'HOME': '/home/cltbld', 04:08:40 INFO - 'LANG': 'en_US.UTF-8', 04:08:40 INFO - 'LANGUAGE': 'en_US:en', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MAIL': '/var/mail/cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SHLVL': '1', 04:08:40 INFO - 'TERM': 'linux', 04:08:40 INFO - 'TMOUT': '86400', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - '_': '/tools/buildbot/bin/python'} 04:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:08:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - Downloading docopt-0.6.1.tar.gz 04:08:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:43 INFO - Running setup.py install for blobuploader 04:08:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:08:43 INFO - Running setup.py install for requests 04:08:44 INFO - Running setup.py install for docopt 04:08:44 INFO - Successfully installed blobuploader requests docopt 04:08:44 INFO - Cleaning up... 04:08:44 INFO - Return code: 0 04:08:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:44 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:08:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:44 INFO - Using env: {'DISPLAY': ':0', 04:08:44 INFO - 'HOME': '/home/cltbld', 04:08:44 INFO - 'LANG': 'en_US.UTF-8', 04:08:44 INFO - 'LANGUAGE': 'en_US:en', 04:08:44 INFO - 'LOGNAME': 'cltbld', 04:08:44 INFO - 'MAIL': '/var/mail/cltbld', 04:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:44 INFO - 'MOZ_NO_REMOTE': '1', 04:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:44 INFO - 'NO_EM_RESTART': '1', 04:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:44 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:44 INFO - 'SHELL': '/bin/bash', 04:08:44 INFO - 'SHLVL': '1', 04:08:44 INFO - 'TERM': 'linux', 04:08:44 INFO - 'TMOUT': '86400', 04:08:44 INFO - 'USER': 'cltbld', 04:08:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:44 INFO - '_': '/tools/buildbot/bin/python'} 04:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:44 INFO - Running setup.py (path:/tmp/pip-Tx2KsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:44 INFO - Running setup.py (path:/tmp/pip-rUMY8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:44 INFO - Running setup.py (path:/tmp/pip-txPKlJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:44 INFO - Running setup.py (path:/tmp/pip-ulqHvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:44 INFO - Running setup.py (path:/tmp/pip-ZSQCQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:44 INFO - Running setup.py (path:/tmp/pip-JWz24f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:44 INFO - Running setup.py (path:/tmp/pip-FCAVF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:44 INFO - Running setup.py (path:/tmp/pip-ZLFUrQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:45 INFO - Running setup.py (path:/tmp/pip-qJ7vXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:45 INFO - Running setup.py (path:/tmp/pip-f5sb6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:45 INFO - Running setup.py (path:/tmp/pip-vpyq5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:45 INFO - Running setup.py (path:/tmp/pip-uBDCxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:45 INFO - Running setup.py (path:/tmp/pip-vxzv8N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:45 INFO - Running setup.py (path:/tmp/pip-O49X8f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:45 INFO - Running setup.py (path:/tmp/pip-m3llxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:45 INFO - Running setup.py (path:/tmp/pip-lh9cyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:45 INFO - Running setup.py (path:/tmp/pip-AsObE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:45 INFO - Running setup.py install for manifestparser 04:08:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozcrash 04:08:45 INFO - Running setup.py install for mozdebug 04:08:45 INFO - Running setup.py install for mozdevice 04:08:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for mozfile 04:08:46 INFO - Running setup.py install for mozhttpd 04:08:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for mozinfo 04:08:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for mozInstall 04:08:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for mozleak 04:08:46 INFO - Running setup.py install for mozlog 04:08:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for moznetwork 04:08:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:08:46 INFO - Running setup.py install for mozprocess 04:08:46 INFO - Running setup.py install for mozprofile 04:08:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:08:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:08:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:08:47 INFO - Running setup.py install for mozrunner 04:08:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:08:47 INFO - Running setup.py install for mozscreenshot 04:08:47 INFO - Running setup.py install for moztest 04:08:47 INFO - Running setup.py install for mozversion 04:08:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:08:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:47 INFO - Cleaning up... 04:08:47 INFO - Return code: 0 04:08:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:47 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:08:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:47 INFO - Using env: {'DISPLAY': ':0', 04:08:47 INFO - 'HOME': '/home/cltbld', 04:08:47 INFO - 'LANG': 'en_US.UTF-8', 04:08:47 INFO - 'LANGUAGE': 'en_US:en', 04:08:47 INFO - 'LOGNAME': 'cltbld', 04:08:47 INFO - 'MAIL': '/var/mail/cltbld', 04:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:47 INFO - 'MOZ_NO_REMOTE': '1', 04:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:47 INFO - 'NO_EM_RESTART': '1', 04:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:47 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:47 INFO - 'SHELL': '/bin/bash', 04:08:47 INFO - 'SHLVL': '1', 04:08:47 INFO - 'TERM': 'linux', 04:08:47 INFO - 'TMOUT': '86400', 04:08:47 INFO - 'USER': 'cltbld', 04:08:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:47 INFO - '_': '/tools/buildbot/bin/python'} 04:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:47 INFO - Running setup.py (path:/tmp/pip-QQSMLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:47 INFO - Running setup.py (path:/tmp/pip-Z1Pcas-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:47 INFO - Running setup.py (path:/tmp/pip-08Jxfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:47 INFO - Running setup.py (path:/tmp/pip-lJnwvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:47 INFO - Running setup.py (path:/tmp/pip-zHc9eN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:48 INFO - Running setup.py (path:/tmp/pip-UDQUd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:48 INFO - Running setup.py (path:/tmp/pip-KG3QbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:48 INFO - Running setup.py (path:/tmp/pip-_PFV1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:48 INFO - Running setup.py (path:/tmp/pip-XuW7fF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:48 INFO - Running setup.py (path:/tmp/pip-QotGK6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:48 INFO - Running setup.py (path:/tmp/pip-KH4AuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:48 INFO - Running setup.py (path:/tmp/pip-u8AedV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:48 INFO - Running setup.py (path:/tmp/pip-PBlMH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:48 INFO - Running setup.py (path:/tmp/pip-C6Vewg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:48 INFO - Running setup.py (path:/tmp/pip-p8jkKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:48 INFO - Running setup.py (path:/tmp/pip-Bu8Ttu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:48 INFO - Running setup.py (path:/tmp/pip-S1TLRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - Downloading blessings-1.6.tar.gz 04:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:51 INFO - Installing collected packages: blessings 04:08:51 INFO - Running setup.py install for blessings 04:08:51 INFO - Successfully installed blessings 04:08:51 INFO - Cleaning up... 04:08:51 INFO - Return code: 0 04:08:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:08:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:51 INFO - Reading from file tmpfile_stdout 04:08:51 INFO - Current package versions: 04:08:51 INFO - argparse == 1.2.1 04:08:51 INFO - blessings == 1.6 04:08:51 INFO - blobuploader == 1.2.4 04:08:51 INFO - docopt == 0.6.1 04:08:51 INFO - manifestparser == 1.1 04:08:51 INFO - mozInstall == 1.12 04:08:51 INFO - mozcrash == 0.17 04:08:51 INFO - mozdebug == 0.1 04:08:51 INFO - mozdevice == 0.48 04:08:51 INFO - mozfile == 1.2 04:08:51 INFO - mozhttpd == 0.7 04:08:51 INFO - mozinfo == 0.9 04:08:51 INFO - mozleak == 0.1 04:08:51 INFO - mozlog == 3.1 04:08:51 INFO - moznetwork == 0.27 04:08:51 INFO - mozprocess == 0.22 04:08:51 INFO - mozprofile == 0.28 04:08:51 INFO - mozrunner == 6.11 04:08:51 INFO - mozscreenshot == 0.1 04:08:51 INFO - mozsystemmonitor == 0.0 04:08:51 INFO - moztest == 0.7 04:08:51 INFO - mozversion == 1.4 04:08:51 INFO - psutil == 3.1.1 04:08:51 INFO - requests == 1.2.3 04:08:51 INFO - wsgiref == 0.1.2 04:08:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 04:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:51 INFO - Using env: {'DISPLAY': ':0', 04:08:51 INFO - 'HOME': '/home/cltbld', 04:08:51 INFO - 'LANG': 'en_US.UTF-8', 04:08:51 INFO - 'LANGUAGE': 'en_US:en', 04:08:51 INFO - 'LOGNAME': 'cltbld', 04:08:51 INFO - 'MAIL': '/var/mail/cltbld', 04:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:51 INFO - 'MOZ_NO_REMOTE': '1', 04:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:51 INFO - 'NO_EM_RESTART': '1', 04:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:51 INFO - 'SHELL': '/bin/bash', 04:08:51 INFO - 'SHLVL': '1', 04:08:51 INFO - 'TERM': 'linux', 04:08:51 INFO - 'TMOUT': '86400', 04:08:51 INFO - 'USER': 'cltbld', 04:08:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:51 INFO - '_': '/tools/buildbot/bin/python'} 04:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 04:08:51 INFO - Cleaning up... 04:08:51 INFO - Return code: 0 04:08:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:51 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:08:51 INFO - Using env: {'DISPLAY': ':0', 04:08:51 INFO - 'HOME': '/home/cltbld', 04:08:51 INFO - 'LANG': 'en_US.UTF-8', 04:08:51 INFO - 'LANGUAGE': 'en_US:en', 04:08:51 INFO - 'LOGNAME': 'cltbld', 04:08:51 INFO - 'MAIL': '/var/mail/cltbld', 04:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:51 INFO - 'MOZ_NO_REMOTE': '1', 04:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:51 INFO - 'NO_EM_RESTART': '1', 04:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:51 INFO - 'SHELL': '/bin/bash', 04:08:51 INFO - 'SHLVL': '1', 04:08:51 INFO - 'TERM': 'linux', 04:08:51 INFO - 'TMOUT': '86400', 04:08:51 INFO - 'USER': 'cltbld', 04:08:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:51 INFO - '_': '/tools/buildbot/bin/python'} 04:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:51 INFO - Downloading/unpacking jsonschema 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:53 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:54 INFO - warning: no files found matching '*.txt' 04:08:54 INFO - no previously-included directories found matching 'build' 04:08:54 INFO - no previously-included directories found matching 'dist' 04:08:54 INFO - no previously-included directories found matching '.git*' 04:08:54 INFO - Installing collected packages: jsonschema, functools32 04:08:54 INFO - Running setup.py install for functools32 04:08:54 INFO - warning: no files found matching '*.txt' 04:08:54 INFO - no previously-included directories found matching 'build' 04:08:54 INFO - no previously-included directories found matching 'dist' 04:08:54 INFO - no previously-included directories found matching '.git*' 04:08:54 INFO - Successfully installed jsonschema functools32 04:08:54 INFO - Cleaning up... 04:08:54 INFO - Return code: 0 04:08:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:54 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 0x7fb1e5187f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4b8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:08:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:08:54 INFO - Using env: {'DISPLAY': ':0', 04:08:54 INFO - 'HOME': '/home/cltbld', 04:08:54 INFO - 'LANG': 'en_US.UTF-8', 04:08:54 INFO - 'LANGUAGE': 'en_US:en', 04:08:54 INFO - 'LOGNAME': 'cltbld', 04:08:54 INFO - 'MAIL': '/var/mail/cltbld', 04:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:54 INFO - 'MOZ_NO_REMOTE': '1', 04:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:54 INFO - 'NO_EM_RESTART': '1', 04:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:54 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:54 INFO - 'SHELL': '/bin/bash', 04:08:54 INFO - 'SHLVL': '1', 04:08:54 INFO - 'TERM': 'linux', 04:08:54 INFO - 'TMOUT': '86400', 04:08:54 INFO - 'USER': 'cltbld', 04:08:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:54 INFO - '_': '/tools/buildbot/bin/python'} 04:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:54 INFO - Downloading/unpacking flake8 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:57 INFO - no previously-included directories found matching 'docs/_build' 04:08:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:57 INFO - Running setup.py install for pep8 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:57 INFO - no previously-included directories found matching 'docs/_build' 04:08:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:08:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:57 INFO - Cleaning up... 04:08:57 INFO - Return code: 0 04:08:57 INFO - Running post-action listener: _resource_record_post_action 04:08:57 INFO - Running post-action listener: _start_resource_monitoring 04:08:57 INFO - Starting resource monitoring. 04:08:57 INFO - ##### 04:08:57 INFO - ##### Running install step. 04:08:57 INFO - ##### 04:08:57 INFO - Running pre-action listener: _resource_record_pre_action 04:08:57 INFO - Running main action method: install 04:08:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:08:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Output received: 04:08:57 INFO - Usage: mozinstall [options] installer 04:08:57 INFO - Options: 04:08:57 INFO - -h, --help show this help message and exit 04:08:57 INFO - -d DEST, --destination=DEST 04:08:57 INFO - Directory to install application into. [default: 04:08:57 INFO - "/builds/slave/test-pgo"] 04:08:57 INFO - --app=APP Application being installed. [default: firefox] 04:08:57 INFO - mkdir: /builds/slave/test-pgo/build/application 04:08:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:08:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:09:14 INFO - Reading from file tmpfile_stdout 04:09:14 INFO - Output received: 04:09:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:09:14 INFO - Running post-action listener: _resource_record_post_action 04:09:14 INFO - ##### 04:09:14 INFO - ##### Running run-tests step. 04:09:14 INFO - ##### 04:09:14 INFO - Running pre-action listener: _resource_record_pre_action 04:09:14 INFO - Running main action method: run_tests 04:09:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:09:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:09:14 INFO - Python 2.7.3 04:09:14 INFO - Return code: 0 04:09:14 INFO - grabbing minidump binary from tooltool 04:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:14 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 0x2cda8b0>, '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 0x2cdb7b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdbc60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:09:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:09:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:09:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:14 INFO - Return code: 0 04:09:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:09:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:09:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:09:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:09:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:09:15 INFO - Return code: 0 04:09:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:09:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:09:15 INFO - Using env: {'DISPLAY': ':0', 04:09:15 INFO - 'HOME': '/home/cltbld', 04:09:15 INFO - 'LANG': 'en_US.UTF-8', 04:09:15 INFO - 'LANGUAGE': 'en_US:en', 04:09:15 INFO - 'LOGNAME': 'cltbld', 04:09:15 INFO - 'MAIL': '/var/mail/cltbld', 04:09:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:15 INFO - 'MOZ_NO_REMOTE': '1', 04:09:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:15 INFO - 'NO_EM_RESTART': '1', 04:09:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:15 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:09:15 INFO - 'SHELL': '/bin/bash', 04:09:15 INFO - 'SHLVL': '1', 04:09:15 INFO - 'TERM': 'linux', 04:09:15 INFO - 'TMOUT': '86400', 04:09:15 INFO - 'USER': 'cltbld', 04:09:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446', 04:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:15 INFO - '_': '/tools/buildbot/bin/python'} 04:09:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:09:15 INFO - mozversion application_buildid: 20160323013058 04:09:15 INFO - mozversion application_changeset: 8786bbb9702f808a01ae45a5153440a7c44699fb 04:09:15 INFO - mozversion application_display_name: Nightly 04:09:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:15 INFO - mozversion application_name: Firefox 04:09:15 INFO - mozversion application_remotingname: firefox 04:09:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:09:15 INFO - mozversion application_vendor: Mozilla 04:09:15 INFO - mozversion application_version: 48.0a1 04:09:15 INFO - mozversion platform_buildid: 20160323013058 04:09:15 INFO - mozversion platform_changeset: 8786bbb9702f808a01ae45a5153440a7c44699fb 04:09:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:09:15 INFO - mozversion platform_version: 48.0a1 04:09:15 INFO - using testdate: 1458731355 04:09:15 INFO - actual date: 1458731355 04:09:15 INFO - starting webserver on 'localhost:57114' 04:09:15 INFO - SUITE-START | Running 2 tests 04:09:15 INFO - TEST-START | dromaeo_css 04:09:15 INFO - operating with platform_type : linux_ 04:09:15 INFO - Initialising browser for dromaeo_css test... 04:09:15 INFO - TEST-INFO | started process 17674 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3MHP1s/profile http://localhost:57114/getInfo.html) 04:09:19 INFO - PROCESS | 17674 | __metrics Screen width/height:1600/1200 04:09:19 INFO - PROCESS | 17674 | colorDepth:24 04:09:19 INFO - PROCESS | 17674 | Browser inner width/height: 1024/697 04:09:19 INFO - PROCESS | 17674 | __metrics 04:09:20 ERROR - PROCESS | 17674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:09:20 INFO - PROCESS | 17674 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:09:21 INFO - TEST-INFO | 17674: exit 0 04:09:21 INFO - Browser initialized. 04:09:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:21 INFO - TEST-INFO | started process 17768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3MHP1s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:33 INFO - PROCESS | 17768 | RSS: Main: 156405760 04:09:33 INFO - PROCESS | 17768 | 04:10:24 INFO - PROCESS | 17768 | 1458731424558 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:12:30 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57114/tests/dromaeo/cssquery-ext.html) 04:12:31 INFO - PROCESS | 17768 | RSS: Main: 246956032 04:12:31 INFO - PROCESS | 17768 | 04:15:33 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-ext.html (next: http://localhost:57114/tests/dromaeo/cssquery-jquery.html) 04:15:34 INFO - PROCESS | 17768 | RSS: Main: 238239744 04:15:34 INFO - PROCESS | 17768 | 04:18:36 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57114/tests/dromaeo/cssquery-mootools.html) 04:18:36 INFO - PROCESS | 17768 | RSS: Main: 232435712 04:18:36 INFO - PROCESS | 17768 | 04:21:38 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57114/tests/dromaeo/cssquery-prototype.html) 04:21:39 INFO - PROCESS | 17768 | RSS: Main: 216825856 04:21:39 INFO - PROCESS | 17768 | 04:24:41 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57114/tests/dromaeo/cssquery-yui.html) 04:24:42 INFO - PROCESS | 17768 | RSS: Main: 221478912 04:24:42 INFO - PROCESS | 17768 | 04:27:44 INFO - PROCESS | 17768 | Cycle 1(1): loaded http://localhost:57114/tests/dromaeo/cssquery-yui.html (next: http://localhost:57114/tests/dromaeo/cssquery-dojo.html) 04:27:45 INFO - PROCESS | 17768 | RSS: Main: 268550144 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | __start_tp_report 04:27:45 INFO - PROCESS | 17768 | _x_x_mozilla_page_load 04:27:45 INFO - PROCESS | 17768 | _x_x_mozilla_page_load_details 04:27:45 INFO - PROCESS | 17768 | |i|pagename|runs| 04:27:45 INFO - PROCESS | 17768 | |0;dojo.html;2979.4488019716346;2997.190758495205;3041.9391612167756;3042.7413669838074;3071.6006919100514;5075.543201111899;5145.974270128644;5147.558004872013;5191.506806853352;5316.175992721134;5241.187615919529;5247.895042099156;5279.2872962150095;5284.497972692588;5301;4714.929276060845;4742.69172503787;4805.0389922015565;4902.264660300948;4928.408590969088;4833.3716616839765;4856.927146092811;4884.462709102014;4890.24201248807;4902.411710594733;4634.119517291704;4722.787474563653;4765.070811191819;4811.615070794345;4837.806487740486;4760.619150467989;4774.092922344744;4780.474147843769;4783.091212669617;4824.035192961422;4636.374089497908;4762.642801789845;4771.71369717818;4773.474917759044;4776.904461910743;5062.721550314768;5117.02776472469;5140.408852981917;5146.871328216787;5156.613254005964;5560.221568980346;5561.304836895388;5563.972180139073;5572.192032155355;5579.191017302509;5380.677159370451;5599.244102046212;5601.131824567198;5604.775808967636;5610;5191.143461328877;5217.426083130853;5221.71280579568;5232.843014709565;5268.841934741964;5673.716314184274;5686.857828554236;5687.203791469197;5691.459311365496;5750.108733146369;5323.148296272578;5414.025475414384;5446.428125046892;5448.809291674773;5458.372287186945;5534.446555344514;5543.6396634218645;5554.444555544494;5557.41647127054;5609.4390560943575;5519.862003449946;5520.282363292747;5528.170774383874;5531.6957567333375;5532.197831314437;5329.840104796862;5477.1510415885605;5531;5542.307211598551;5586.55307575393;4199.517055538652;4224.049588842486;4227.513835908849;4253.3619957006695;4260.147970405869;3747.981260093682;3770.5286839145106;3789.905252368713;3816.217675376541;3820.8471661133244;5130.050940576006;5230.63385563007;5308.256844041837;5324.1747529133045;5329.653572517774;5575.275214222206;5585.972070139705;5588.9720551397795;5589.077802162597;5597.63615365;5288.867778305573;5306.814261500829;5309.41596424393;5310.681359118388;5359.919601205985;4625.745583992845;4671.602913752369;4721.102990431876;4726.834560790356;4728.71627702339;5728.255326807488;5734.856628584235;5738.397468265772;5739.741711622987;5747.109198074305;5565.66606003633;5567.805126820542;5570.2480165177185;5576.609637325349;5617.073182924772;5561.193626924154;5760.654360738369;5816.040353341651;5838.5621078418435;5847.8245652630485;5496.532794712334;5496.587755918242;5498.890022199454;5498.945010550004;5508.80719174843;5461;5565.026120428828;5575.470330318613;5575.77696892136;5589.413111623221;5363.463653634605;5432;5438.45615438453;5471.72641367938;5483.917741233964;5399.784008639767;5420.403755586961;5425.131978883517;5426.430224826337;5429.212764149097;5136.460671629425;5299.8410047698635;5347.090994531017;5362.51737343641;5401.8919621606565;5471.835844924659;5484.862878428071;5494.532964697885;5501.889962200654;5529.751161197675;5387.084195686664;5396.703181325065;5402.432744561765;5405.72971351423;5448.645838020516 04:27:45 INFO - PROCESS | 17768 | |1;ext.html;513.7097539889962;567.2002476508125;571.7798647520705;589.5195415736175;595.4640823259067;30294.242643933914;38200.61799382005;38463.423048654295;38534.80732596337;38581.61418385815;41354.58645413545;41872.58127418725;41887.16225675492;41919;41931.37102943458;7854.450188486809;8664.350173736979;8832.425892317011;8855.380123391365;10154.441505717183;10252.692419227398;10393.688189354332;10424.94787526065;10429.843552346721;10454.529546170403;10413.583456661725;10506.68479945599;10507;10511.421871797049;10517.421541815198;8118.675252989873;10377.584896604127;10550;10793.028627423491;10798.838017429745;10246.692599222035;10381.532831022547;10382.273240873143;10383.84424233637;10388.740281492948;38626.227475450614;38727.419088713694;39035;39045.80477097625;39069.60930390688;3607.350676878161;3610.3862343401424;3620.8008559529217;3637.3634613942454;3676.5771936227407;31531.84234078838;31843.52234716481;31916;32382.514262286084;32908.341833163446;4345.652347812167;4350.390945267665;4363.52001279859;4380.67144964129;4382.496012958519;340417;341131;341454;341503;341785;60952.39047609467;61558.69220653868;61772.69113654403;61778.69110654508;61867.6906615464;65021.34978650153;65262.67368663221;65320.34679653238;65361.346386536476;65441;16583.419580314632;17041.23314450828;17150.742738858928;17163.399281025104;17219.913900430416;13103.410346534429;13122.212667239995;13131.409086591126;13160.341982900816;13238.801417978739;19220.327288544835;19791.505212369804;19798.60402791965;19847.30534431288;19861.30485433032;6680.3987641112535;7845.686172553148;7968.203179681986;8028.59857007159;8126.431149819456;1080.8702955645374;1154.6247469572422;1157.438642258504;1241.1870225002638;1243.6828608704723;30097.849510752745;31076;32278.354432911212;32360.83819580887;32547.51178732321;1083.815751322277;1106.3472551194834;1249.6625911003978;1254.5170109507906;1299.4672184404537;16531;16604.58488537796;16618.086005269586;16784.832151678573;17038.233279502452;295952;298973;299467;299867;300049;51668.22497662538;51765.741171294656;51875.48124518782;51917.22124168065;51959.74020129951;1286.633309506786;1403.6561042544643;1406.8241469816273;1422.6372275069998;1444.364479628981;27753.583696244168;29190.70809291965;29430.705692942796;29491.55762663519;29912.55131173078;44845.55154448414;45278.54721452743;45346;45411.31883021823;45421.77289113533;253932;254850;255543;255724;256047;30324;34377.828110859286;34485.655143448246;35129.82435087808;35885.28229435449;40237.59762402339;40574.79712601418;40697;41186.79406602948;41349;33069.33861322808;34481.13797155091;34558.308833823685;34809.47785783165;34882.65117348794;35821.46267806037;36791.8160409207;36893;37020.629793701715;37718.8114059428;37587.248255034196;37701.4344784823;38365.80817096008;38476.42285365666;38575.22849543049;30529.847350763102;33225.169370764954;33379.83310083434;33481.497777532866;33677.831610841786;26621.467570648092;26668;26944.191674249803;26948.730512694623;27066.32334191582 04:27:45 INFO - PROCESS | 17768 | |2;jquery.html;355.60705420510334;361.2504054087768;361.6004315231669;364.4424031232215;365.76042692036725;17339.133043347847;17529.649407011868;18849.905750471247;18878.056097195153;18905.24379024841;17381.217845196967;17865.72960976512;18030.459086227434;18057.458276251702;18062;5409.9459005409835;5657.377688454267;5660.094384898417;5660.5471562275125;5663.037283661767;4117.711760176789;4292.5278219396;5565.554755619561;6042.848928776772;6260.342664020258;6185.783497577586;6185.907211391833;6213.440790328869;6221.937780622181;6223.190985171921;5962.135490353896;6077.301110372297;6109.053096770008;6117.235345581802;6181.165542651752;3661.743677942545;5216.26972223889;5343.65266257692;5426.2674538937135;5427.62006659534;19482.80517194824;20092.79907200924;20193.19227230909;20400.795992040188;20417.183312667476;2322.7096612923383;2397.6403539469043;2431.3313838694326;2532.6789252043336;2789.8710801566795;13220.140690855063;13432.731345373135;13516.12145210558;13625.046246762731;13827.723445531134;1852.4164888060352;1853.9258429662798;1924.0860591219198;1947.4352437793023;1992.3325685895243;62288.37711622871;62422.37577624211;63449.68275158595;63526.682366588335;64018.999999999534;10611.628592999208;10628.362298261975;10639.680809575726;10664.573417063231;10815.56737730482;13748.381322840496;13855.51505697316;13862.376193071335;13866.237356945263;13884.375203115884;8014.398920081017;8207.179282071864;8261.669533218605;8300.418970671995;8364.749057528285;8023.679052837938;8081.353491720648;8088.191180881865;8160.3471722262075;8172;4648.395708557933;4658.836940707059;4662.487126416091;4681.438227412732;4736.715797052188;1714.6827836850223;1737.044625455994;1767.646470705864;1822.4988128264833;1908.4179325305915;990.8216521026285;1059.510151144819;1128.8306753986967;1150.384544268812;1159.5709587452527;16879.32482700703;17618.29526818913;17776.466705998842;17816.55458613519;17961.371352002618;1002.774375765447;1047.4219025351574;1066.233125040534;1108.362691452402;1115.676453828397;10061.346012509164;10105.343152695052;10124.74688132788;10147.441890695934;10245.334053286513;476240;477414;479300;488596;502774;73662;79035;79452.6027369871;80146;80493.19506804974;1048.4128887822844;1058.0847566854616;1063.016709543669;1091.165258577189;1091.6015654286127;15673.294701738678;15679.764803528184;15818.525444236231;15887.443939462064;16194.190290485663;36024.459633106046;36024.64687086287;36662.81668591747;36803;37029.81485092557;50456.49543504665;50981;51124.233136503724;51181;51184.23223651574;7958.721444749406;8101.837963240584;8359.582020899052;8408;8460.576971151295;9658;12588.748225035632;12686.365681716063;12743.362831858185;13169.078164528391;5817.709114544171;8852.734417967471;9827.459489728133;10846.13230941507;10925.726856828644;11400.258983166068;11479.827802583135;11485.655430337103;11598.07215422781;11619.825702614637;10721.463926803473;10902.618408355669;11059.612913547988;11300.547978081113;11334;8350.958245208734;8408.789780255298;8412.747617571482;8453.492790432594;8624.482531048157;7566.848663026599;7585.734499292498;7667.194944530967;7831.373490120891;7926.295846392823 04:27:45 INFO - PROCESS | 17768 | |3;mootools.html;1344.247221555928;1486.7472529669956;1505;1679.6388776413069;1815.5188874948142;7380.926190738091;7570.432217583682;7571.659275332602;7579.583122928237;7583.696652133908;7289.854202915939;7397.741079062221;7446.96276518618;7457.776266711994;7487.2138425465355;1962.3426152238947;2007.5282308657454;2203.636399993999;2251.6059689554304;2279.225063478417;2226.0984301357894;2226.9888650556722;2242.506648537319;2245.135622785223;2245.7080579524722;2138.17680193126;2146.130817019102;2243.6858839762444;2245.5733410652006;2248.15694114707;2207.8233741300655;2234.7988681018705;2242.9551408971893;2245.191730976855;2247.7976982071527;2210.10490751246;2216.5345277491747;2235.653473711577;2237.0268933014027;2237.7090978172896;7684;7733.729319473848;7751.7674469766;7753.728619498291;7756.108047574488;4802.207635740098;4913.041956818422;4913.164761990471;4952.33143525623;4954.405471343426;3343.6823501767294;3347.44767113426;3368.6294507604143;3398;3431.673990970854;1093.2620481175175;1099.8900109989017;1108.5898217659517;1113.9554417823276;1122.2537012886503;10587.417692026935;10599.84100238497;10611.41637209961;10620.840687389695;10623.681289561326;4319.43847299849;4351.129774045204;4407.2507673695545;4413.691041627119;4420.58004489573;9145.131212534798;9163.31275154366;9171.082891710776;9174.311926605531;9178.082191780768;4935.383077115361;4936.543719602726;4945.802167913315;4948.257761335756;4948.4309304429735;4008.0581063450068;4331.371951067078;4415.580519850609;4463.218936686067;4471.7987690554;3663.7618554793853;3703.129764505339;3730.2539492101687;3736.290104880064;3778.4899038629983;1167.3696204049718;1182.361524776611;1188.3820413385165;1195.748892732536;1196.3240768965507;1386.4800699737598;1400.6568390744128;1419.141419441244;1435.3612642374044;1438.6331485471137;7370.8894366584545;7524.623768811538;7552.055993000875;7558.811029724191;7563.546187228784;1141.3437273567731;1148.615213903335;1186.128195776104;1186.9406529673654;1206.4450352837794;5922.3485416604135;5927.7848041151465;5961.344252132262;5972.074328479092;5978.103284507359;8687.826243475096;9430.858537121949;9549.427034377959;9560.091791279818;9573.760655983517;9313.39462934907;9410.058994100673;9418.858717119248;9432.528373581294;9488.28837837165;7102.617200169698;7430.4798664093;7465.477416580788;7500.587467689329;7514.624268786539;7203;7324.08448943882;7341.449391295781;7341.6696248670005;7346.706131754884;8246.83506329858;8333.125021872616;8386.496810191407;8415.20055594742;8567.314614830673;8415.368847336596;8580.785480363042;8588.785280368042;8721.127887211482;8724.476531408136;5904.0553511437965;6385.648789316632;6522.34776522344;6660.866782664417;6754.797356079325;7388.261173882569;7389.482736208413;7410.407167426701;7435.925640743523;7440.144383395762;6595.208574971034;6744.932550674431;6767.086443330088;6798.52410331272;6890.173179218526;6597.472202223715;6761.357671021246;6820.147481564804;6902.033715279966;6919;6570.671466426755;7069.681864316221;7093.6453177341955;7114.964425177841;7153.713851445884;6358.936410635834;6378.075179098912;6408.647524386017;6410.1987251593555;6413.262474815456;6425.7750978717395;6505.447037001908;6507.121538592419;6512.772052978123;6512.804615861532 04:27:45 INFO - PROCESS | 17768 | |4;prototype.html;335.7884532744371;336.7524869221124;337.421322432029;339.1656524948626;344.1877169879085;6090.086487026948;6123.693815309228;6131.816045518636;6147.508199344053;6157.599756015856;5997.550183736226;6025.849353766158;6028.487578555828;6029.246344206974;6039.758409663608;4441.356003379508;4558.293464513005;4625.5836974672275;4688.859334219979;4701.717896926187;4665.393498845146;4683.437987441512;4706.152892479352;4710.599599034086;4714.717116972975;4630.837920672777;4650.511696271894;4659.207934651101;4661.300804879262;4664.533546645325;4440.400545926307;4531.252343363358;4573.314002899559;4610.147122782262;4612.677112602119;4019.577944315863;4027.35562310029;4037.6164264394833;4037.81829817656;4046.676265898721;5848.2689663792025;5857.4435428634215;5875.177475153482;5882.823515294505;5899.1446240295345;5371.543418809406;5378.865528361822;5380.7309634518115;5391.272178255925;5401.7299135043095;6361.045843123568;6368.267649220353;6380.138681278015;6382.776602818925;6389.936100638981;4241.724287921306;4365.585269399402;4383.167198232326;4391.6267117295065;4488.326750987346;6647.734090636417;6687.632180230085;6739.2249891262645;6778.932210677879;6786.4570834333135;4450.46594408673;4500.369948207253;4501.954980450219;4507.459104907432;4509.143262780061;4566.543345665407;4567.474740404829;4568.246239370533;4568.885777855514;4574.725516469022;5287.629865909426;5305;5316.308879845596;5319.946800532022;5322.866928326823;6336.493080553545;6377.1390862233;6484.157059582224;6490.48076153916;6492.350764923564;1584.1049806859087;1586.1514089961815;1589.7774311596386;1602.1828867277773;1609.0184987157825;990.4057565460666;1034.8654674892216;1036.9740756481149;1054.0408228512017;1073.5652060915343;6131.816045518642;6174.845628859224;6192.659403732838;6193.38066193377;6197.5351848611535;6580.243272023778;6580.341965803382;6585.6707164641575;6585.967070164715;6589.901151482732;6147.385261473817;6155.661438620829;6161.537884658668;6166.321704612489;6183.752649893954;3540.044188069207;3565.732570057204;3569.196930690574;3572.0891172751303;3575.481555174485;6688.130543029375;6845.931540684629;6862.348076932683;6867.587944723333;6868;6620.139381880324;6677.332266773284;6682.899756503559;6684.565503242274;6686.866262674719;6755.3582409671;6766.966165169143;6771.762988295386;6790.151231096113;6791.592504449848;6563.442107420923;6563.573367731082;6568.244651865097;6569.178852643419;6570.967145164243;6265.122882796503;6493;6503.187101612299;6507.446867016357;6510.641914694737;6808.5914845109455;6815.250322464426;6816.182058153054;6834.043233947351;6847.657617119224;4492.842750503717;4494.932576011428;4495.483019452805;4495.550444955478;4510.436195475566;6532.118164047983;6542.640154791532;6545.934540654533;6550.574212676161;6554.344565543408;6230.408111229426;6388.840278993062;6389.584676995981;6396.968015159894;6401.327860574759;6329.303776584664;6343.873122537616;6348.714307856065;6350.618962862243;6352.428281454691;6211.068339748893;6229.190205273286;6247.96876015617;6256.280527739368;6257.749690012349;6365.586236894587;6371.490280777434;6384.968075159594;6390.329015453311;6398.296187419473;6036.215292012011;6093.329733729198;6234.781782637768;6241.750329986749;6254.718537665725 04:27:45 INFO - PROCESS | 17768 | |5;yui.html;727.3163226567027;758.3857075768627;851.2253848997414;855.5893171277783;857.9785505362369;14265.144091354514;14335.211563364011;14354.856451435482;14481.92759036206;14497.130172189649;13358.532451364204;15325;15622.921885390557;15744.370225190978;15760.921195394036;666.9566478178928;813.3086876155265;819.1890028871404;819.2094628683319;820.8563501387263;799.1489064146695;818.472085504849;823.1028179284579;823.6417158536026;824.2087595907935;868.0841711993844;877.1535468273115;878.8110556230409;879.3492815316652;879.6965047058754;704.5244459989538;863.3050394432479;867.7049803066988;872.5506364222431;876.1939016105199;632.1971096707202;634.4163369699887;636.017353189319;637.6174295422755;638.6104476269472;13923.443062277598;13954.441822327197;13963.511277105252;13983.440662373492;14071.226082565454;12686.175398599155;13012.674683132902;13084.672883177902;13260.204387736767;13282.800757988638;10420.270581059329;10906.563737450493;10967.561297548089;11112;11224.214304998653;3676.9080772980888;3748.0629842539365;3793.3172029034763;3836.673882719972;3901.707371947087;56579.43420565824;56984.43015569833;57025.999999999585;57599.424005760244;57816.421835781526;10223.335483193569;10352.063882921122;10494.42280674555;10501.789964200825;10543.789124217472;19150.233990640496;19262.80737192638;19268.32560860363;19285.132169052427;19313.4205973821;8154.3884208684585;8240.876386854203;8256.091829898707;8265.586720663943;8509.74470765878;4547.977260113678;4686.3204835299375;4704.317873908332;4736.597389221886;4789.233722604366;3128.8279144647263;3157.873685052572;3159.794613350125;3166.176794033568;3178.586783718148;565.2312854517852;579.2527639345197;584.0946532874028;589.6491587505427;591.6745789815584;620.2897682153908;722.5628494760595;732.4543215304632;750.8310630108182;755.2749360613763;9566.378185417925;9647.1317581418;9741.805163896683;9886.505674716236;9985.1512621428;684.4353408438059;696.4811215644276;704.6793708862456;712.2094475132599;721.4264659595634;4190.371444283382;4328.177646247203;4336.958253664802;4349.478062632441;4394.780260987001;65710.34289657042;66097.66951165213;66232;66983;67013.32986670168;54976.72511637416;55576.16635750467;55695;55965;56340.71829640825;49262.26106608404;49420.258696119585;49839.75080124576;50184;50372.49627503678;8216.917830821616;8359.582020899052;8587.65649374018;8615.784605384915;8656.740297791077;36984.815075924445;37108;37461.4380784283;37726.43410348902;37786.811065944494;49065;49503;49698.503014969385;50442;50553;11681.591144309908;11784.410779461165;11843.58096372368;11861.347625880315;12077.51689932393;11959.342236176746;12248.816267756169;12284.81572776427;12499.437525311201;12803.80794288105;12023.939880300542;12235.755284894074;12318.815217771562;12381.75236495283;12462.501499940263;12053.397330133283;12200.286633837613;12259.712730163204;12319.876801231872;12333.383330833243;11736.70658233551;11818.40907954616;12171.208871423329;12305.630831075083;12463;10484.947575262075;10485.68542943713;10536.84194737095;10595.417252051211;10763.892361076289;10544.683659490227;10679.733006674895;10750.73123171927;10781.568737250422;10912.345259284468 04:27:45 INFO - PROCESS | 17768 | __end_tp_report 04:27:45 INFO - PROCESS | 17768 | __start_cc_report 04:27:45 INFO - PROCESS | 17768 | _x_x_mozilla_cycle_collect,775 04:27:45 INFO - PROCESS | 17768 | __end_cc_report 04:27:45 INFO - PROCESS | 17768 | __startTimestamp1458732465031__endTimestamp 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | ------- Summary: start ------- 04:27:45 INFO - PROCESS | 17768 | Number of tests: 6 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#0] dojo.html Cycles:165 Average:5173.11 Median:5380.68 stddev:580.92 (10.8%) stddev-sans-first:556.63 04:27:45 INFO - PROCESS | 17768 | Values: 2979.4 2997.2 3041.9 3042.7 3071.6 5075.5 5146.0 5147.6 5191.5 5316.2 5241.2 5247.9 5279.3 5284.5 5301.0 4714.9 4742.7 4805.0 4902.3 4928.4 4833.4 4856.9 4884.5 4890.2 4902.4 4634.1 4722.8 4765.1 4811.6 4837.8 4760.6 4774.1 4780.5 4783.1 4824.0 4636.4 4762.6 4771.7 4773.5 4776.9 5062.7 5117.0 5140.4 5146.9 5156.6 5560.2 5561.3 5564.0 5572.2 5579.2 5380.7 5599.2 5601.1 5604.8 5610.0 5191.1 5217.4 5221.7 5232.8 5268.8 5673.7 5686.9 5687.2 5691.5 5750.1 5323.1 5414.0 5446.4 5448.8 5458.4 5534.4 5543.6 5554.4 5557.4 5609.4 5519.9 5520.3 5528.2 5531.7 5532.2 5329.8 5477.2 5531.0 5542.3 5586.6 4199.5 4224.0 4227.5 4253.4 4260.1 3748.0 3770.5 3789.9 3816.2 3820.8 5130.1 5230.6 5308.3 5324.2 5329.7 5575.3 5586.0 5589.0 5589.1 5597.6 5288.9 5306.8 5309.4 5310.7 5359.9 4625.7 4671.6 4721.1 4726.8 4728.7 5728.3 5734.9 5738.4 5739.7 5747.1 5565.7 5567.8 5570.2 5576.6 5617.1 5561.2 5760.7 5816.0 5838.6 5847.8 5496.5 5496.6 5498.9 5498.9 5508.8 5461.0 5565.0 5575.5 5575.8 5589.4 5363.5 5432.0 5438.5 5471.7 5483.9 5399.8 5420.4 5425.1 5426.4 5429.2 5136.5 5299.8 5347.1 5362.5 5401.9 5471.8 5484.9 5494.5 5501.9 5529.8 5387.1 5396.7 5402.4 5405.7 5448.6 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#1] ext.html Cycles:180 Average:47515.73 Median:33430.67 stddev:78445.01 (234.6%) stddev-sans-first:78585.69 04:27:45 INFO - PROCESS | 17768 | Values: 513.7 567.2 571.8 589.5 595.5 30294.2 38200.6 38463.4 38534.8 38581.6 41354.6 41872.6 41887.2 41919.0 41931.4 7854.5 8664.4 8832.4 8855.4 10154.4 10252.7 10393.7 10424.9 10429.8 10454.5 10413.6 10506.7 10507.0 10511.4 10517.4 8118.7 10377.6 10550.0 10793.0 10798.8 10246.7 10381.5 10382.3 10383.8 10388.7 38626.2 38727.4 39035.0 39045.8 39069.6 3607.4 3610.4 3620.8 3637.4 3676.6 31531.8 31843.5 31916.0 32382.5 32908.3 4345.7 4350.4 4363.5 4380.7 4382.5 340417.0 341131.0 341454.0 341503.0 341785.0 60952.4 61558.7 61772.7 61778.7 61867.7 65021.3 65262.7 65320.3 65361.3 65441.0 16583.4 17041.2 17150.7 17163.4 17219.9 13103.4 13122.2 13131.4 13160.3 13238.8 19220.3 19791.5 19798.6 19847.3 19861.3 6680.4 7845.7 7968.2 8028.6 8126.4 1080.9 1154.6 1157.4 1241.2 1243.7 30097.8 31076.0 32278.4 32360.8 32547.5 1083.8 1106.3 1249.7 1254.5 1299.5 16531.0 16604.6 16618.1 16784.8 17038.2 295952.0 298973.0 299467.0 299867.0 300049.0 51668.2 51765.7 51875.5 51917.2 51959.7 1286.6 1403.7 1406.8 1422.6 1444.4 27753.6 29190.7 29430.7 29491.6 29912.6 44845.6 45278.5 45346.0 45411.3 45421.8 253932.0 254850.0 255543.0 255724.0 256047.0 30324.0 34377.8 34485.7 35129.8 35885.3 40237.6 40574.8 40697.0 41186.8 41349.0 33069.3 34481.1 34558.3 34809.5 34882.7 35821.5 36791.8 36893.0 37020.6 37718.8 37587.2 37701.4 38365.8 38476.4 38575.2 30529.8 33225.2 33379.8 33481.5 33677.8 26621.5 26668.0 26944.2 26948.7 27066.3 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#2] jquery.html Cycles:180 Average:27205.71 Median:18190.03 stddev:79433.08 (436.7%) stddev-sans-first:79630.32 04:27:45 INFO - PROCESS | 17768 | Values: 355.6 361.3 361.6 364.4 365.8 17339.1 17529.6 18849.9 18878.1 18905.2 17381.2 17865.7 18030.5 18057.5 18062.0 5409.9 5657.4 5660.1 5660.5 5663.0 4117.7 4292.5 5565.6 6042.8 6260.3 6185.8 6185.9 6213.4 6221.9 6223.2 5962.1 6077.3 6109.1 6117.2 6181.2 3661.7 5216.3 5343.7 5426.3 5427.6 19482.8 20092.8 20193.2 20400.8 20417.2 2322.7 2397.6 2431.3 2532.7 2789.9 13220.1 13432.7 13516.1 13625.0 13827.7 1852.4 1853.9 1924.1 1947.4 1992.3 62288.4 62422.4 63449.7 63526.7 64019.0 10611.6 10628.4 10639.7 10664.6 10815.6 13748.4 13855.5 13862.4 13866.2 13884.4 8014.4 8207.2 8261.7 8300.4 8364.7 8023.7 8081.4 8088.2 8160.3 8172.0 4648.4 4658.8 4662.5 4681.4 4736.7 1714.7 1737.0 1767.6 1822.5 1908.4 990.8 1059.5 1128.8 1150.4 1159.6 16879.3 17618.3 17776.5 17816.6 17961.4 1002.8 1047.4 1066.2 1108.4 1115.7 10061.3 10105.3 10124.7 10147.4 10245.3 476240.0 477414.0 479300.0 488596.0 502774.0 73662.0 79035.0 79452.6 80146.0 80493.2 1048.4 1058.1 1063.0 1091.2 1091.6 15673.3 15679.8 15818.5 15887.4 16194.2 36024.5 36024.6 36662.8 36803.0 37029.8 50456.5 50981.0 51124.2 51181.0 51184.2 7958.7 8101.8 8359.6 8408.0 8460.6 9658.0 12588.7 12686.4 12743.4 13169.1 5817.7 8852.7 9827.5 10846.1 10925.7 11400.3 11479.8 11485.7 11598.1 11619.8 10721.5 10902.6 11059.6 11300.5 11334.0 8351.0 8408.8 8412.7 8453.5 8624.5 7566.8 7585.7 7667.2 7831.4 7926.3 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#3] mootools.html Cycles:180 Average:5469.01 Median:6168.52 stddev:2785.88 (45.2%) stddev-sans-first:2776.44 04:27:45 INFO - PROCESS | 17768 | Values: 1344.2 1486.7 1505.0 1679.6 1815.5 7380.9 7570.4 7571.7 7579.6 7583.7 7289.9 7397.7 7447.0 7457.8 7487.2 1962.3 2007.5 2203.6 2251.6 2279.2 2226.1 2227.0 2242.5 2245.1 2245.7 2138.2 2146.1 2243.7 2245.6 2248.2 2207.8 2234.8 2243.0 2245.2 2247.8 2210.1 2216.5 2235.7 2237.0 2237.7 7684.0 7733.7 7751.8 7753.7 7756.1 4802.2 4913.0 4913.2 4952.3 4954.4 3343.7 3347.4 3368.6 3398.0 3431.7 1093.3 1099.9 1108.6 1114.0 1122.3 10587.4 10599.8 10611.4 10620.8 10623.7 4319.4 4351.1 4407.3 4413.7 4420.6 9145.1 9163.3 9171.1 9174.3 9178.1 4935.4 4936.5 4945.8 4948.3 4948.4 4008.1 4331.4 4415.6 4463.2 4471.8 3663.8 3703.1 3730.3 3736.3 3778.5 1167.4 1182.4 1188.4 1195.7 1196.3 1386.5 1400.7 1419.1 1435.4 1438.6 7370.9 7524.6 7552.1 7558.8 7563.5 1141.3 1148.6 1186.1 1186.9 1206.4 5922.3 5927.8 5961.3 5972.1 5978.1 8687.8 9430.9 9549.4 9560.1 9573.8 9313.4 9410.1 9418.9 9432.5 9488.3 7102.6 7430.5 7465.5 7500.6 7514.6 7203.0 7324.1 7341.4 7341.7 7346.7 8246.8 8333.1 8386.5 8415.2 8567.3 8415.4 8580.8 8588.8 8721.1 8724.5 5904.1 6385.6 6522.3 6660.9 6754.8 7388.3 7389.5 7410.4 7435.9 7440.1 6595.2 6744.9 6767.1 6798.5 6890.2 6597.5 6761.4 6820.1 6902.0 6919.0 6570.7 7069.7 7093.6 7115.0 7153.7 6358.9 6378.1 6408.6 6410.2 6413.3 6425.8 6505.4 6507.1 6512.8 6512.8 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#4] prototype.html Cycles:180 Average:5343.44 Median:6147.45 stddev:1612.33 (26.2%) stddev-sans-first:1572.43 04:27:45 INFO - PROCESS | 17768 | Values: 335.8 336.8 337.4 339.2 344.2 6090.1 6123.7 6131.8 6147.5 6157.6 5997.6 6025.8 6028.5 6029.2 6039.8 4441.4 4558.3 4625.6 4688.9 4701.7 4665.4 4683.4 4706.2 4710.6 4714.7 4630.8 4650.5 4659.2 4661.3 4664.5 4440.4 4531.3 4573.3 4610.1 4612.7 4019.6 4027.4 4037.6 4037.8 4046.7 5848.3 5857.4 5875.2 5882.8 5899.1 5371.5 5378.9 5380.7 5391.3 5401.7 6361.0 6368.3 6380.1 6382.8 6389.9 4241.7 4365.6 4383.2 4391.6 4488.3 6647.7 6687.6 6739.2 6778.9 6786.5 4450.5 4500.4 4502.0 4507.5 4509.1 4566.5 4567.5 4568.2 4568.9 4574.7 5287.6 5305.0 5316.3 5319.9 5322.9 6336.5 6377.1 6484.2 6490.5 6492.4 1584.1 1586.2 1589.8 1602.2 1609.0 990.4 1034.9 1037.0 1054.0 1073.6 6131.8 6174.8 6192.7 6193.4 6197.5 6580.2 6580.3 6585.7 6586.0 6589.9 6147.4 6155.7 6161.5 6166.3 6183.8 3540.0 3565.7 3569.2 3572.1 3575.5 6688.1 6845.9 6862.3 6867.6 6868.0 6620.1 6677.3 6682.9 6684.6 6686.9 6755.4 6767.0 6771.8 6790.2 6791.6 6563.4 6563.6 6568.2 6569.2 6571.0 6265.1 6493.0 6503.2 6507.4 6510.6 6808.6 6815.3 6816.2 6834.0 6847.7 4492.8 4494.9 4495.5 4495.6 4510.4 6532.1 6542.6 6545.9 6550.6 6554.3 6230.4 6388.8 6389.6 6397.0 6401.3 6329.3 6343.9 6348.7 6350.6 6352.4 6211.1 6229.2 6248.0 6256.3 6257.7 6365.6 6371.5 6385.0 6390.3 6398.3 6036.2 6093.3 6234.8 6241.8 6254.7 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - PROCESS | 17768 | [#5] yui.html Cycles:180 Average:15138.89 Median:4617.15 stddev:17984.54 (389.5%) stddev-sans-first:18002.43 04:27:45 INFO - PROCESS | 17768 | Values: 727.3 758.4 851.2 855.6 858.0 14265.1 14335.2 14354.9 14481.9 14497.1 13358.5 15325.0 15622.9 15744.4 15760.9 667.0 813.3 819.2 819.2 820.9 799.1 818.5 823.1 823.6 824.2 868.1 877.2 878.8 879.3 879.7 704.5 863.3 867.7 872.6 876.2 632.2 634.4 636.0 637.6 638.6 13923.4 13954.4 13963.5 13983.4 14071.2 12686.2 13012.7 13084.7 13260.2 13282.8 10420.3 10906.6 10967.6 11112.0 11224.2 3676.9 3748.1 3793.3 3836.7 3901.7 56579.4 56984.4 57026.0 57599.4 57816.4 10223.3 10352.1 10494.4 10501.8 10543.8 19150.2 19262.8 19268.3 19285.1 19313.4 8154.4 8240.9 8256.1 8265.6 8509.7 4548.0 4686.3 4704.3 4736.6 4789.2 3128.8 3157.9 3159.8 3166.2 3178.6 565.2 579.3 584.1 589.6 591.7 620.3 722.6 732.5 750.8 755.3 9566.4 9647.1 9741.8 9886.5 9985.2 684.4 696.5 704.7 712.2 721.4 4190.4 4328.2 4337.0 4349.5 4394.8 65710.3 66097.7 66232.0 66983.0 67013.3 54976.7 55576.2 55695.0 55965.0 56340.7 49262.3 49420.3 49839.8 50184.0 50372.5 8216.9 8359.6 8587.7 8615.8 8656.7 36984.8 37108.0 37461.4 37726.4 37786.8 49065.0 49503.0 49698.5 50442.0 50553.0 11681.6 11784.4 11843.6 11861.3 12077.5 11959.3 12248.8 12284.8 12499.4 12803.8 12023.9 12235.8 12318.8 12381.8 12462.5 12053.4 12200.3 12259.7 12319.9 12333.4 11736.7 11818.4 12171.2 12305.6 12463.0 10484.9 10485.7 10536.8 10595.4 10763.9 10544.7 10679.7 10750.7 10781.6 10912.3 04:27:45 INFO - PROCESS | 17768 | -------- Summary: end -------- 04:27:45 INFO - PROCESS | 17768 | 04:27:45 INFO - TEST-INFO | 17768: exit 0 04:27:45 INFO - TEST-OK | dromaeo_css | took 1110101ms 04:27:45 INFO - TEST-START | kraken 04:27:45 INFO - operating with platform_type : linux_ 04:27:45 INFO - Initialising browser for kraken test... 04:27:45 INFO - TEST-INFO | started process 17952 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2AFRMB/profile http://localhost:57114/getInfo.html) 04:27:49 INFO - PROCESS | 17952 | __metrics Screen width/height:1600/1200 04:27:49 INFO - PROCESS | 17952 | colorDepth:24 04:27:49 INFO - PROCESS | 17952 | Browser inner width/height: 1024/697 04:27:49 INFO - PROCESS | 17952 | __metrics 04:27:50 ERROR - PROCESS | 17952 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:27:50 INFO - PROCESS | 17952 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:27:51 INFO - TEST-INFO | 17952: exit 0 04:27:51 INFO - Browser initialized. 04:27:51 INFO - Running cycle 1/1 for kraken test... 04:27:51 INFO - TEST-INFO | started process 18034 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2AFRMB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:02 INFO - PROCESS | 18034 | RSS: Main: 156512256 04:28:02 INFO - PROCESS | 18034 | 04:28:05 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57114/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:05 INFO - PROCESS | 18034 | RSS: Main: 198332416 04:28:05 INFO - PROCESS | 18034 | 04:28:08 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57114/tests/kraken/driver.html?testName=audio-dft) 04:28:09 INFO - PROCESS | 18034 | RSS: Main: 187351040 04:28:09 INFO - PROCESS | 18034 | 04:28:11 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57114/tests/kraken/driver.html?testName=audio-fft) 04:28:12 INFO - PROCESS | 18034 | RSS: Main: 171495424 04:28:12 INFO - PROCESS | 18034 | 04:28:14 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57114/tests/kraken/driver.html?testName=audio-oscillator) 04:28:15 INFO - PROCESS | 18034 | RSS: Main: 174030848 04:28:15 INFO - PROCESS | 18034 | 04:28:17 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:17 INFO - PROCESS | 18034 | RSS: Main: 174346240 04:28:17 INFO - PROCESS | 18034 | 04:28:20 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57114/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:21 INFO - PROCESS | 18034 | RSS: Main: 176472064 04:28:21 INFO - PROCESS | 18034 | 04:28:24 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57114/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:25 INFO - PROCESS | 18034 | RSS: Main: 175955968 04:28:25 INFO - PROCESS | 18034 | 04:28:28 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57114/tests/kraken/driver.html?testName=json-parse-financial) 04:28:28 INFO - PROCESS | 18034 | RSS: Main: 177233920 04:28:28 INFO - PROCESS | 18034 | 04:28:30 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:30 INFO - PROCESS | 18034 | RSS: Main: 187965440 04:28:30 INFO - PROCESS | 18034 | 04:28:32 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:33 INFO - PROCESS | 18034 | RSS: Main: 185110528 04:28:33 INFO - PROCESS | 18034 | 04:28:35 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:35 INFO - PROCESS | 18034 | RSS: Main: 197443584 04:28:35 INFO - PROCESS | 18034 | 04:28:38 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:38 INFO - PROCESS | 18034 | RSS: Main: 202788864 04:28:38 INFO - PROCESS | 18034 | 04:28:41 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:41 INFO - PROCESS | 18034 | RSS: Main: 200159232 04:28:41 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | Cycle 1(1): loaded http://localhost:57114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57114/tests/kraken/driver.html?testName=ai-astar) 04:28:43 INFO - PROCESS | 18034 | RSS: Main: 260595712 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | __start_tp_report 04:28:43 INFO - PROCESS | 18034 | _x_x_mozilla_page_load 04:28:43 INFO - PROCESS | 18034 | _x_x_mozilla_page_load_details 04:28:43 INFO - PROCESS | 18034 | |i|pagename|runs| 04:28:43 INFO - PROCESS | 18034 | |0;ai-astar;109;110;105;109;110;112;100;109;108;109 04:28:43 INFO - PROCESS | 18034 | |1;audio-beat-detection;148;124;144;165;131;149;150;123;172;120 04:28:43 INFO - PROCESS | 18034 | |2;audio-dft;160;161;161;164;160;161;159;162;161;161 04:28:43 INFO - PROCESS | 18034 | |3;audio-fft;72;72;125;92;75;75;72;112;94;75 04:28:43 INFO - PROCESS | 18034 | |4;audio-oscillator;92;94;147;93;93;93;143;93;93;147 04:28:43 INFO - PROCESS | 18034 | |5;imaging-gaussian-blur;117;116;117;116;117;117;116;117;117;116 04:28:43 INFO - PROCESS | 18034 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;145 04:28:43 INFO - PROCESS | 18034 | |7;imaging-desaturate;95;96;96;96;95;95;95;94;95;95 04:28:43 INFO - PROCESS | 18034 | |8;json-parse-financial;55;54;55;54;55;54;55;65;55;54 04:28:43 INFO - PROCESS | 18034 | |9;json-stringify-tinderbox;61;60;60;60;61;61;61;62;61;61 04:28:43 INFO - PROCESS | 18034 | |10;stanford-crypto-aes;80;78;79;79;79;78;79;79;78;79 04:28:43 INFO - PROCESS | 18034 | |11;stanford-crypto-ccm;117;109;109;110;115;109;117;108;113;112 04:28:43 INFO - PROCESS | 18034 | |12;stanford-crypto-pbkdf2;149;131;143;140;141;129;141;153;139;138 04:28:43 INFO - PROCESS | 18034 | |13;stanford-crypto-sha256-iterative;62;63;65;62;62;66;63;62;62;62 04:28:43 INFO - PROCESS | 18034 | __end_tp_report 04:28:43 INFO - PROCESS | 18034 | __start_cc_report 04:28:43 INFO - PROCESS | 18034 | _x_x_mozilla_cycle_collect,1052 04:28:43 INFO - PROCESS | 18034 | __end_cc_report 04:28:43 INFO - PROCESS | 18034 | __startTimestamp1458732523554__endTimestamp 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | ------- Summary: start ------- 04:28:43 INFO - PROCESS | 18034 | Number of tests: 14 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.35 (3.1%) stddev-sans-first:3.54 04:28:43 INFO - PROCESS | 18034 | Values: 109.0 110.0 105.0 109.0 110.0 112.0 100.0 109.0 108.0 109.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.50 stddev:17.85 (12.0%) stddev-sans-first:18.83 04:28:43 INFO - PROCESS | 18034 | Values: 148.0 124.0 144.0 165.0 131.0 149.0 150.0 123.0 172.0 120.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 04:28:43 INFO - PROCESS | 18034 | Values: 160.0 161.0 161.0 164.0 160.0 161.0 159.0 162.0 161.0 161.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#3] audio-fft Cycles:10 Average:86.40 Median:75.00 stddev:18.99 (25.3%) stddev-sans-first:19.42 04:28:43 INFO - PROCESS | 18034 | Values: 72.0 72.0 125.0 92.0 75.0 75.0 72.0 112.0 94.0 75.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:93.00 stddev:25.47 (27.4%) stddev-sans-first:26.28 04:28:43 INFO - PROCESS | 18034 | Values: 92.0 94.0 147.0 93.0 93.0 93.0 143.0 93.0 93.0 147.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:28:43 INFO - PROCESS | 18034 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 04:28:43 INFO - PROCESS | 18034 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:28:43 INFO - PROCESS | 18034 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.34 (6.1%) stddev-sans-first:3.54 04:28:43 INFO - PROCESS | 18034 | Values: 55.0 54.0 55.0 54.0 55.0 54.0 55.0 65.0 55.0 54.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:28:43 INFO - PROCESS | 18034 | Values: 61.0 60.0 60.0 60.0 61.0 61.0 61.0 62.0 61.0 61.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:0.63 (0.8%) stddev-sans-first:0.50 04:28:43 INFO - PROCESS | 18034 | Values: 80.0 78.0 79.0 79.0 79.0 78.0 79.0 79.0 78.0 79.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#11] stanford-crypto-ccm Cycles:10 Average:111.90 Median:112.50 stddev:3.45 (3.1%) stddev-sans-first:3.12 04:28:43 INFO - PROCESS | 18034 | Values: 117.0 109.0 109.0 110.0 115.0 109.0 117.0 108.0 113.0 112.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:141.00 stddev:7.20 (5.1%) stddev-sans-first:6.93 04:28:43 INFO - PROCESS | 18034 | Values: 149.0 131.0 143.0 140.0 141.0 129.0 141.0 153.0 139.0 138.0 04:28:43 INFO - PROCESS | 18034 | 04:28:43 INFO - PROCESS | 18034 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:1.45 (2.3%) stddev-sans-first:1.50 04:28:43 INFO - PROCESS | 18034 | Values: 62.0 63.0 65.0 62.0 62.0 66.0 63.0 62.0 62.0 62.0 04:28:43 INFO - PROCESS | 18034 | -------- Summary: end -------- 04:28:43 INFO - PROCESS | 18034 | 04:28:44 INFO - TEST-INFO | 18034: exit 0 04:28:44 INFO - TEST-OK | kraken | took 58816ms 04:28:44 INFO - SUITE-END | took 1168s 04:28:44 INFO - Completed test suite (00:19:29) 04:28:44 INFO - javascript benchmark 04:28:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2979.4488019716346, 2997.190758495205, 3041.9391612167756, 3042.7413669838074, 3071.6006919100514, 5075.543201111899, 5145.974270128644, 5147.558004872013, 5191.506806853352, 5316.175992721134, 5241.187615919529, 5247.895042099156, 5279.2872962150095, 5284.497972692588, 5301.0, 4714.929276060845, 4742.69172503787, 4805.0389922015565, 4902.264660300948, 4928.408590969088, 4833.3716616839765, 4856.927146092811, 4884.462709102014, 4890.24201248807, 4902.411710594733, 4634.119517291704, 4722.787474563653, 4765.070811191819, 4811.615070794345, 4837.806487740486, 4760.619150467989, 4774.092922344744, 4780.474147843769, 4783.091212669617, 4824.035192961422, 4636.374089497908, 4762.642801789845, 4771.71369717818, 4773.474917759044, 4776.904461910743, 5062.721550314768, 5117.02776472469, 5140.408852981917, 5146.871328216787, 5156.613254005964, 5560.221568980346, 5561.304836895388, 5563.972180139073, 5572.192032155355, 5579.191017302509, 5380.677159370451, 5599.244102046212, 5601.131824567198, 5604.775808967636, 5610.0, 5191.143461328877, 5217.426083130853, 5221.71280579568, 5232.843014709565, 5268.841934741964, 5673.716314184274, 5686.857828554236, 5687.203791469197, 5691.459311365496, 5750.108733146369, 5323.148296272578, 5414.025475414384, 5446.428125046892, 5448.809291674773, 5458.372287186945, 5534.446555344514, 5543.6396634218645, 5554.444555544494, 5557.41647127054, 5609.4390560943575, 5519.862003449946, 5520.282363292747, 5528.170774383874, 5531.6957567333375, 5532.197831314437, 5329.840104796862, 5477.1510415885605, 5531.0, 5542.307211598551, 5586.55307575393, 4199.517055538652, 4224.049588842486, 4227.513835908849, 4253.3619957006695, 4260.147970405869, 3747.981260093682, 3770.5286839145106, 3789.905252368713, 3816.217675376541, 3820.8471661133244, 5130.050940576006, 5230.63385563007, 5308.256844041837, 5324.1747529133045, 5329.653572517774, 5575.275214222206, 5585.972070139705, 5588.9720551397795, 5589.077802162597, 5597.63615365, 5288.867778305573, 5306.814261500829, 5309.41596424393, 5310.681359118388, 5359.919601205985, 4625.745583992845, 4671.602913752369, 4721.102990431876, 4726.834560790356, 4728.71627702339, 5728.255326807488, 5734.856628584235, 5738.397468265772, 5739.741711622987, 5747.109198074305, 5565.66606003633, 5567.805126820542, 5570.2480165177185, 5576.609637325349, 5617.073182924772, 5561.193626924154, 5760.654360738369, 5816.040353341651, 5838.5621078418435, 5847.8245652630485, 5496.532794712334, 5496.587755918242, 5498.890022199454, 5498.945010550004, 5508.80719174843, 5461.0, 5565.026120428828, 5575.470330318613, 5575.77696892136, 5589.413111623221, 5363.463653634605, 5432.0, 5438.45615438453, 5471.72641367938, 5483.917741233964, 5399.784008639767, 5420.403755586961, 5425.131978883517, 5426.430224826337, 5429.212764149097, 5136.460671629425, 5299.8410047698635, 5347.090994531017, 5362.51737343641, 5401.8919621606565, 5471.835844924659, 5484.862878428071, 5494.532964697885, 5501.889962200654, 5529.751161197675, 5387.084195686664, 5396.703181325065, 5402.432744561765, 5405.72971351423, 5448.645838020516], "unit": "score", "name": "dojo.html", "value": 5134.214269257442}, {"lowerIsBetter": false, "replicates": [513.7097539889962, 567.2002476508125, 571.7798647520705, 589.5195415736175, 595.4640823259067, 30294.242643933914, 38200.61799382005, 38463.423048654295, 38534.80732596337, 38581.61418385815, 41354.58645413545, 41872.58127418725, 41887.16225675492, 41919.0, 41931.37102943458, 7854.450188486809, 8664.350173736979, 8832.425892317011, 8855.380123391365, 10154.441505717183, 10252.692419227398, 10393.688189354332, 10424.94787526065, 10429.843552346721, 10454.529546170403, 10413.583456661725, 10506.68479945599, 10507.0, 10511.421871797049, 10517.421541815198, 8118.675252989873, 10377.584896604127, 10550.0, 10793.028627423491, 10798.838017429745, 10246.692599222035, 10381.532831022547, 10382.273240873143, 10383.84424233637, 10388.740281492948, 38626.227475450614, 38727.419088713694, 39035.0, 39045.80477097625, 39069.60930390688, 3607.350676878161, 3610.3862343401424, 3620.8008559529217, 3637.3634613942454, 3676.5771936227407, 31531.84234078838, 31843.52234716481, 31916.0, 32382.514262286084, 32908.341833163446, 4345.652347812167, 4350.390945267665, 4363.52001279859, 4380.67144964129, 4382.496012958519, 340417.0, 341131.0, 341454.0, 341503.0, 341785.0, 60952.39047609467, 61558.69220653868, 61772.69113654403, 61778.69110654508, 61867.6906615464, 65021.34978650153, 65262.67368663221, 65320.34679653238, 65361.346386536476, 65441.0, 16583.419580314632, 17041.23314450828, 17150.742738858928, 17163.399281025104, 17219.913900430416, 13103.410346534429, 13122.212667239995, 13131.409086591126, 13160.341982900816, 13238.801417978739, 19220.327288544835, 19791.505212369804, 19798.60402791965, 19847.30534431288, 19861.30485433032, 6680.3987641112535, 7845.686172553148, 7968.203179681986, 8028.59857007159, 8126.431149819456, 1080.8702955645374, 1154.6247469572422, 1157.438642258504, 1241.1870225002638, 1243.6828608704723, 30097.849510752745, 31076.0, 32278.354432911212, 32360.83819580887, 32547.51178732321, 1083.815751322277, 1106.3472551194834, 1249.6625911003978, 1254.5170109507906, 1299.4672184404537, 16531.0, 16604.58488537796, 16618.086005269586, 16784.832151678573, 17038.233279502452, 295952.0, 298973.0, 299467.0, 299867.0, 300049.0, 51668.22497662538, 51765.741171294656, 51875.48124518782, 51917.22124168065, 51959.74020129951, 1286.633309506786, 1403.6561042544643, 1406.8241469816273, 1422.6372275069998, 1444.364479628981, 27753.583696244168, 29190.70809291965, 29430.705692942796, 29491.55762663519, 29912.55131173078, 44845.55154448414, 45278.54721452743, 45346.0, 45411.31883021823, 45421.77289113533, 253932.0, 254850.0, 255543.0, 255724.0, 256047.0, 30324.0, 34377.828110859286, 34485.655143448246, 35129.82435087808, 35885.28229435449, 40237.59762402339, 40574.79712601418, 40697.0, 41186.79406602948, 41349.0, 33069.33861322808, 34481.13797155091, 34558.308833823685, 34809.47785783165, 34882.65117348794, 35821.46267806037, 36791.8160409207, 36893.0, 37020.629793701715, 37718.8114059428, 37587.248255034196, 37701.4344784823, 38365.80817096008, 38476.42285365666, 38575.22849543049, 30529.847350763102, 33225.169370764954, 33379.83310083434, 33481.497777532866, 33677.831610841786, 26621.467570648092, 26668.0, 26944.191674249803, 26948.730512694623, 27066.32334191582], "unit": "score", "name": "ext.html", "value": 19476.5377606936}, {"lowerIsBetter": false, "replicates": [355.60705420510334, 361.2504054087768, 361.6004315231669, 364.4424031232215, 365.76042692036725, 17339.133043347847, 17529.649407011868, 18849.905750471247, 18878.056097195153, 18905.24379024841, 17381.217845196967, 17865.72960976512, 18030.459086227434, 18057.458276251702, 18062.0, 5409.9459005409835, 5657.377688454267, 5660.094384898417, 5660.5471562275125, 5663.037283661767, 4117.711760176789, 4292.5278219396, 5565.554755619561, 6042.848928776772, 6260.342664020258, 6185.783497577586, 6185.907211391833, 6213.440790328869, 6221.937780622181, 6223.190985171921, 5962.135490353896, 6077.301110372297, 6109.053096770008, 6117.235345581802, 6181.165542651752, 3661.743677942545, 5216.26972223889, 5343.65266257692, 5426.2674538937135, 5427.62006659534, 19482.80517194824, 20092.79907200924, 20193.19227230909, 20400.795992040188, 20417.183312667476, 2322.7096612923383, 2397.6403539469043, 2431.3313838694326, 2532.6789252043336, 2789.8710801566795, 13220.140690855063, 13432.731345373135, 13516.12145210558, 13625.046246762731, 13827.723445531134, 1852.4164888060352, 1853.9258429662798, 1924.0860591219198, 1947.4352437793023, 1992.3325685895243, 62288.37711622871, 62422.37577624211, 63449.68275158595, 63526.682366588335, 64018.999999999534, 10611.628592999208, 10628.362298261975, 10639.680809575726, 10664.573417063231, 10815.56737730482, 13748.381322840496, 13855.51505697316, 13862.376193071335, 13866.237356945263, 13884.375203115884, 8014.398920081017, 8207.179282071864, 8261.669533218605, 8300.418970671995, 8364.749057528285, 8023.679052837938, 8081.353491720648, 8088.191180881865, 8160.3471722262075, 8172.0, 4648.395708557933, 4658.836940707059, 4662.487126416091, 4681.438227412732, 4736.715797052188, 1714.6827836850223, 1737.044625455994, 1767.646470705864, 1822.4988128264833, 1908.4179325305915, 990.8216521026285, 1059.510151144819, 1128.8306753986967, 1150.384544268812, 1159.5709587452527, 16879.32482700703, 17618.29526818913, 17776.466705998842, 17816.55458613519, 17961.371352002618, 1002.774375765447, 1047.4219025351574, 1066.233125040534, 1108.362691452402, 1115.676453828397, 10061.346012509164, 10105.343152695052, 10124.74688132788, 10147.441890695934, 10245.334053286513, 476240.0, 477414.0, 479300.0, 488596.0, 502774.0, 73662.0, 79035.0, 79452.6027369871, 80146.0, 80493.19506804974, 1048.4128887822844, 1058.0847566854616, 1063.016709543669, 1091.165258577189, 1091.6015654286127, 15673.294701738678, 15679.764803528184, 15818.525444236231, 15887.443939462064, 16194.190290485663, 36024.459633106046, 36024.64687086287, 36662.81668591747, 36803.0, 37029.81485092557, 50456.49543504665, 50981.0, 51124.233136503724, 51181.0, 51184.23223651574, 7958.721444749406, 8101.837963240584, 8359.582020899052, 8408.0, 8460.576971151295, 9658.0, 12588.748225035632, 12686.365681716063, 12743.362831858185, 13169.078164528391, 5817.709114544171, 8852.734417967471, 9827.459489728133, 10846.13230941507, 10925.726856828644, 11400.258983166068, 11479.827802583135, 11485.655430337103, 11598.07215422781, 11619.825702614637, 10721.463926803473, 10902.618408355669, 11059.612913547988, 11300.547978081113, 11334.0, 8350.958245208734, 8408.789780255298, 8412.747617571482, 8453.492790432594, 8624.482531048157, 7566.848663026599, 7585.734499292498, 7667.194944530967, 7831.373490120891, 7926.295846392823], "unit": "score", "name": "jquery.html", "value": 8766.899825081342}, {"lowerIsBetter": false, "replicates": [1344.247221555928, 1486.7472529669956, 1505.0, 1679.6388776413069, 1815.5188874948142, 7380.926190738091, 7570.432217583682, 7571.659275332602, 7579.583122928237, 7583.696652133908, 7289.854202915939, 7397.741079062221, 7446.96276518618, 7457.776266711994, 7487.2138425465355, 1962.3426152238947, 2007.5282308657454, 2203.636399993999, 2251.6059689554304, 2279.225063478417, 2226.0984301357894, 2226.9888650556722, 2242.506648537319, 2245.135622785223, 2245.7080579524722, 2138.17680193126, 2146.130817019102, 2243.6858839762444, 2245.5733410652006, 2248.15694114707, 2207.8233741300655, 2234.7988681018705, 2242.9551408971893, 2245.191730976855, 2247.7976982071527, 2210.10490751246, 2216.5345277491747, 2235.653473711577, 2237.0268933014027, 2237.7090978172896, 7684.0, 7733.729319473848, 7751.7674469766, 7753.728619498291, 7756.108047574488, 4802.207635740098, 4913.041956818422, 4913.164761990471, 4952.33143525623, 4954.405471343426, 3343.6823501767294, 3347.44767113426, 3368.6294507604143, 3398.0, 3431.673990970854, 1093.2620481175175, 1099.8900109989017, 1108.5898217659517, 1113.9554417823276, 1122.2537012886503, 10587.417692026935, 10599.84100238497, 10611.41637209961, 10620.840687389695, 10623.681289561326, 4319.43847299849, 4351.129774045204, 4407.2507673695545, 4413.691041627119, 4420.58004489573, 9145.131212534798, 9163.31275154366, 9171.082891710776, 9174.311926605531, 9178.082191780768, 4935.383077115361, 4936.543719602726, 4945.802167913315, 4948.257761335756, 4948.4309304429735, 4008.0581063450068, 4331.371951067078, 4415.580519850609, 4463.218936686067, 4471.7987690554, 3663.7618554793853, 3703.129764505339, 3730.2539492101687, 3736.290104880064, 3778.4899038629983, 1167.3696204049718, 1182.361524776611, 1188.3820413385165, 1195.748892732536, 1196.3240768965507, 1386.4800699737598, 1400.6568390744128, 1419.141419441244, 1435.3612642374044, 1438.6331485471137, 7370.8894366584545, 7524.623768811538, 7552.055993000875, 7558.811029724191, 7563.546187228784, 1141.3437273567731, 1148.615213903335, 1186.128195776104, 1186.9406529673654, 1206.4450352837794, 5922.3485416604135, 5927.7848041151465, 5961.344252132262, 5972.074328479092, 5978.103284507359, 8687.826243475096, 9430.858537121949, 9549.427034377959, 9560.091791279818, 9573.760655983517, 9313.39462934907, 9410.058994100673, 9418.858717119248, 9432.528373581294, 9488.28837837165, 7102.617200169698, 7430.4798664093, 7465.477416580788, 7500.587467689329, 7514.624268786539, 7203.0, 7324.08448943882, 7341.449391295781, 7341.6696248670005, 7346.706131754884, 8246.83506329858, 8333.125021872616, 8386.496810191407, 8415.20055594742, 8567.314614830673, 8415.368847336596, 8580.785480363042, 8588.785280368042, 8721.127887211482, 8724.476531408136, 5904.0553511437965, 6385.648789316632, 6522.34776522344, 6660.866782664417, 6754.797356079325, 7388.261173882569, 7389.482736208413, 7410.407167426701, 7435.925640743523, 7440.144383395762, 6595.208574971034, 6744.932550674431, 6767.086443330088, 6798.52410331272, 6890.173179218526, 6597.472202223715, 6761.357671021246, 6820.147481564804, 6902.033715279966, 6919.0, 6570.671466426755, 7069.681864316221, 7093.6453177341955, 7114.964425177841, 7153.713851445884, 6358.936410635834, 6378.075179098912, 6408.647524386017, 6410.1987251593555, 6413.262474815456, 6425.7750978717395, 6505.447037001908, 6507.121538592419, 6512.772052978123, 6512.804615861532], "unit": "score", "name": "mootools.html", "value": 4534.590248538637}, {"lowerIsBetter": false, "replicates": [335.7884532744371, 336.7524869221124, 337.421322432029, 339.1656524948626, 344.1877169879085, 6090.086487026948, 6123.693815309228, 6131.816045518636, 6147.508199344053, 6157.599756015856, 5997.550183736226, 6025.849353766158, 6028.487578555828, 6029.246344206974, 6039.758409663608, 4441.356003379508, 4558.293464513005, 4625.5836974672275, 4688.859334219979, 4701.717896926187, 4665.393498845146, 4683.437987441512, 4706.152892479352, 4710.599599034086, 4714.717116972975, 4630.837920672777, 4650.511696271894, 4659.207934651101, 4661.300804879262, 4664.533546645325, 4440.400545926307, 4531.252343363358, 4573.314002899559, 4610.147122782262, 4612.677112602119, 4019.577944315863, 4027.35562310029, 4037.6164264394833, 4037.81829817656, 4046.676265898721, 5848.2689663792025, 5857.4435428634215, 5875.177475153482, 5882.823515294505, 5899.1446240295345, 5371.543418809406, 5378.865528361822, 5380.7309634518115, 5391.272178255925, 5401.7299135043095, 6361.045843123568, 6368.267649220353, 6380.138681278015, 6382.776602818925, 6389.936100638981, 4241.724287921306, 4365.585269399402, 4383.167198232326, 4391.6267117295065, 4488.326750987346, 6647.734090636417, 6687.632180230085, 6739.2249891262645, 6778.932210677879, 6786.4570834333135, 4450.46594408673, 4500.369948207253, 4501.954980450219, 4507.459104907432, 4509.143262780061, 4566.543345665407, 4567.474740404829, 4568.246239370533, 4568.885777855514, 4574.725516469022, 5287.629865909426, 5305.0, 5316.308879845596, 5319.946800532022, 5322.866928326823, 6336.493080553545, 6377.1390862233, 6484.157059582224, 6490.48076153916, 6492.350764923564, 1584.1049806859087, 1586.1514089961815, 1589.7774311596386, 1602.1828867277773, 1609.0184987157825, 990.4057565460666, 1034.8654674892216, 1036.9740756481149, 1054.0408228512017, 1073.5652060915343, 6131.816045518642, 6174.845628859224, 6192.659403732838, 6193.38066193377, 6197.5351848611535, 6580.243272023778, 6580.341965803382, 6585.6707164641575, 6585.967070164715, 6589.901151482732, 6147.385261473817, 6155.661438620829, 6161.537884658668, 6166.321704612489, 6183.752649893954, 3540.044188069207, 3565.732570057204, 3569.196930690574, 3572.0891172751303, 3575.481555174485, 6688.130543029375, 6845.931540684629, 6862.348076932683, 6867.587944723333, 6868.0, 6620.139381880324, 6677.332266773284, 6682.899756503559, 6684.565503242274, 6686.866262674719, 6755.3582409671, 6766.966165169143, 6771.762988295386, 6790.151231096113, 6791.592504449848, 6563.442107420923, 6563.573367731082, 6568.244651865097, 6569.178852643419, 6570.967145164243, 6265.122882796503, 6493.0, 6503.187101612299, 6507.446867016357, 6510.641914694737, 6808.5914845109455, 6815.250322464426, 6816.182058153054, 6834.043233947351, 6847.657617119224, 4492.842750503717, 4494.932576011428, 4495.483019452805, 4495.550444955478, 4510.436195475566, 6532.118164047983, 6542.640154791532, 6545.934540654533, 6550.574212676161, 6554.344565543408, 6230.408111229426, 6388.840278993062, 6389.584676995981, 6396.968015159894, 6401.327860574759, 6329.303776584664, 6343.873122537616, 6348.714307856065, 6350.618962862243, 6352.428281454691, 6211.068339748893, 6229.190205273286, 6247.96876015617, 6256.280527739368, 6257.749690012349, 6365.586236894587, 6371.490280777434, 6384.968075159594, 6390.329015453311, 6398.296187419473, 6036.215292012011, 6093.329733729198, 6234.781782637768, 6241.750329986749, 6254.718537665725], "unit": "score", "name": "prototype.html", "value": 4814.143675466295}, {"lowerIsBetter": false, "replicates": [727.3163226567027, 758.3857075768627, 851.2253848997414, 855.5893171277783, 857.9785505362369, 14265.144091354514, 14335.211563364011, 14354.856451435482, 14481.92759036206, 14497.130172189649, 13358.532451364204, 15325.0, 15622.921885390557, 15744.370225190978, 15760.921195394036, 666.9566478178928, 813.3086876155265, 819.1890028871404, 819.2094628683319, 820.8563501387263, 799.1489064146695, 818.472085504849, 823.1028179284579, 823.6417158536026, 824.2087595907935, 868.0841711993844, 877.1535468273115, 878.8110556230409, 879.3492815316652, 879.6965047058754, 704.5244459989538, 863.3050394432479, 867.7049803066988, 872.5506364222431, 876.1939016105199, 632.1971096707202, 634.4163369699887, 636.017353189319, 637.6174295422755, 638.6104476269472, 13923.443062277598, 13954.441822327197, 13963.511277105252, 13983.440662373492, 14071.226082565454, 12686.175398599155, 13012.674683132902, 13084.672883177902, 13260.204387736767, 13282.800757988638, 10420.270581059329, 10906.563737450493, 10967.561297548089, 11112.0, 11224.214304998653, 3676.9080772980888, 3748.0629842539365, 3793.3172029034763, 3836.673882719972, 3901.707371947087, 56579.43420565824, 56984.43015569833, 57025.999999999585, 57599.424005760244, 57816.421835781526, 10223.335483193569, 10352.063882921122, 10494.42280674555, 10501.789964200825, 10543.789124217472, 19150.233990640496, 19262.80737192638, 19268.32560860363, 19285.132169052427, 19313.4205973821, 8154.3884208684585, 8240.876386854203, 8256.091829898707, 8265.586720663943, 8509.74470765878, 4547.977260113678, 4686.3204835299375, 4704.317873908332, 4736.597389221886, 4789.233722604366, 3128.8279144647263, 3157.873685052572, 3159.794613350125, 3166.176794033568, 3178.586783718148, 565.2312854517852, 579.2527639345197, 584.0946532874028, 589.6491587505427, 591.6745789815584, 620.2897682153908, 722.5628494760595, 732.4543215304632, 750.8310630108182, 755.2749360613763, 9566.378185417925, 9647.1317581418, 9741.805163896683, 9886.505674716236, 9985.1512621428, 684.4353408438059, 696.4811215644276, 704.6793708862456, 712.2094475132599, 721.4264659595634, 4190.371444283382, 4328.177646247203, 4336.958253664802, 4349.478062632441, 4394.780260987001, 65710.34289657042, 66097.66951165213, 66232.0, 66983.0, 67013.32986670168, 54976.72511637416, 55576.16635750467, 55695.0, 55965.0, 56340.71829640825, 49262.26106608404, 49420.258696119585, 49839.75080124576, 50184.0, 50372.49627503678, 8216.917830821616, 8359.582020899052, 8587.65649374018, 8615.784605384915, 8656.740297791077, 36984.815075924445, 37108.0, 37461.4380784283, 37726.43410348902, 37786.811065944494, 49065.0, 49503.0, 49698.503014969385, 50442.0, 50553.0, 11681.591144309908, 11784.410779461165, 11843.58096372368, 11861.347625880315, 12077.51689932393, 11959.342236176746, 12248.816267756169, 12284.81572776427, 12499.437525311201, 12803.80794288105, 12023.939880300542, 12235.755284894074, 12318.815217771562, 12381.75236495283, 12462.501499940263, 12053.397330133283, 12200.286633837613, 12259.712730163204, 12319.876801231872, 12333.383330833243, 11736.70658233551, 11818.40907954616, 12171.208871423329, 12305.630831075083, 12463.0, 10484.947575262075, 10485.68542943713, 10536.84194737095, 10595.417252051211, 10763.892361076289, 10544.683659490227, 10679.733006674895, 10750.73123171927, 10781.568737250422, 10912.345259284468], "unit": "score", "name": "yui.html", "value": 6724.252827695919}], "name": "dromaeo_css", "value": 7105.51450981145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 109.0, 110.0, 112.0, 100.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 144.0, 165.0, 131.0, 149.0, 150.0, 123.0, 172.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 164.0, 160.0, 161.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 125.0, 92.0, 75.0, 75.0, 72.0, 112.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 147.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.8}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 79.0, 79.0, 79.0, 78.0, 79.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [117.0, 109.0, 109.0, 110.0, 115.0, 109.0, 117.0, 108.0, 113.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.9}, {"lowerIsBetter": true, "replicates": [149.0, 131.0, 143.0, 140.0, 141.0, 129.0, 141.0, 153.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 65.0, 62.0, 62.0, 66.0, 63.0, 62.0, 62.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.9}], "name": "kraken", "value": 1474.2000000000003}]} 04:28:44 INFO - Return code: 0 04:28:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:44 ERROR - # TBPL SUCCESS # 04:28:44 INFO - Running post-action listener: _resource_record_post_action 04:28:44 INFO - Running post-run listener: _resource_record_post_run 04:28:45 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 480325632; Read time: 8; Write time: 345092 04:28:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 200445952; Read time: 0; Write time: 161564 04:28:45 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279879680; Read time: 8; Write time: 183528 04:28:45 INFO - Running post-run listener: _upload_blobber_files 04:28:45 INFO - Blob upload gear active. 04:28:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:28:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:28:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:28:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:28:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:47 INFO - (blobuploader) - INFO - Done attempting. 04:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:48 INFO - (blobuploader) - INFO - Done attempting. 04:28:48 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:48 INFO - Return code: 0 04:28:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92d7336ff4ad72e50ee42894e6db352cb8cbc235e303c84404a5591e6bbefd942c208f311eaa53855ffc28b83f24c0228c7c4cf20074475569aa2c9e51a95978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e31571d206df33be93649f11b202ad1ada1b3bd46af36bc0cc125f79c7f2f19e68ed5553fe90df5dc4a2075582e2a2d7052d3d15e6c16430637a77874e082"} 04:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:28:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:28:48 INFO - Contents: 04:28:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92d7336ff4ad72e50ee42894e6db352cb8cbc235e303c84404a5591e6bbefd942c208f311eaa53855ffc28b83f24c0228c7c4cf20074475569aa2c9e51a95978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e31571d206df33be93649f11b202ad1ada1b3bd46af36bc0cc125f79c7f2f19e68ed5553fe90df5dc4a2075582e2a2d7052d3d15e6c16430637a77874e082"} 04:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:48 INFO - Copying logs to upload dir... 04:28:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.514136 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-03-23 04:28:48.427427) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:28:48.430635) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92d7336ff4ad72e50ee42894e6db352cb8cbc235e303c84404a5591e6bbefd942c208f311eaa53855ffc28b83f24c0228c7c4cf20074475569aa2c9e51a95978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e31571d206df33be93649f11b202ad1ada1b3bd46af36bc0cc125f79c7f2f19e68ed5553fe90df5dc4a2075582e2a2d7052d3d15e6c16430637a77874e082"} build_url:https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009824 build_url: 'https://queue.taskcluster.net/v1/task/Z0_0LXQNShG7Y5i7X25-uA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92d7336ff4ad72e50ee42894e6db352cb8cbc235e303c84404a5591e6bbefd942c208f311eaa53855ffc28b83f24c0228c7c4cf20074475569aa2c9e51a95978", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/586e31571d206df33be93649f11b202ad1ada1b3bd46af36bc0cc125f79c7f2f19e68ed5553fe90df5dc4a2075582e2a2d7052d3d15e6c16430637a77874e082"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:28:48.453086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:28:48.453400) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1458728064.371424-587656446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:28:48.537146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:28:48.537476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:28:48.537771) ========= ========= Total master_lag: 0.30 =========