builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1447715975.39 results: success (0) buildid: 20151116133012 builduid: e287d31c7ae94c2fb4f126e732f15672 revision: 85237019374be7a67a2720a5913bfbde64012ebf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.394203) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.394624) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.394923) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006651 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.416380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.416670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.424556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.424887) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004748 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.473410) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.473686) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.474566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.474881) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-16 15:19:35-- 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% 59.5M=0s 2015-11-16 15:19:35 (59.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.614295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.614612) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.663857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:35.664238) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 85237019374be7a67a2720a5913bfbde64012ebf --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 85237019374be7a67a2720a5913bfbde64012ebf --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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-16 15:19:36,049 truncating revision to first 12 chars 2015-11-16 15:19:36,049 Setting DEBUG logging. 2015-11-16 15:19:36,049 attempt 1/10 2015-11-16 15:19:36,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/85237019374b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 15:19:36,291 unpacking tar archive at: mozilla-inbound-85237019374b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:36.194094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:36.194570) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:36.205552) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:36.205950) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 15:19:36.206422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 15:19:36.206714) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:36 INFO - MultiFileLogger online at 20151116 15:19:36 in /builds/slave/test-pgo 15:19:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:19:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:19:36 INFO - {'append_to_log': False, 15:19:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:19:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:19:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:19:36 INFO - 'branch': 'Mozilla-Inbound', 15:19:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:36 INFO - 'config_files': ('talos/linux_config.py',), 15:19:36 INFO - 'default_actions': ('clobber', 15:19:36 INFO - 'read-buildbot-config', 15:19:36 INFO - 'download-and-extract', 15:19:36 INFO - 'populate-webroot', 15:19:36 INFO - 'create-virtualenv', 15:19:36 INFO - 'install', 15:19:36 INFO - 'run-tests'), 15:19:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:36 INFO - 'download_minidump_stackwalk': True, 15:19:36 INFO - 'download_symbols': 'ondemand', 15:19:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:19:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:19:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:19:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:19:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:36 INFO - 'installer_path': 'installer.exe', 15:19:36 INFO - 'log_level': 'info', 15:19:36 INFO - 'log_name': 'talos', 15:19:36 INFO - 'log_to_console': True, 15:19:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:36 INFO - 'opt_config_files': (), 15:19:36 INFO - 'pip_index': False, 15:19:36 INFO - 'sps_profile': False, 15:19:36 INFO - 'sps_profile_interval': 0, 15:19:36 INFO - 'suite': 'dromaeojs', 15:19:36 INFO - 'system_bits': '64', 15:19:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:36 INFO - 'title': 'talos-linux64-ix-008', 15:19:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:36 INFO - 'use_talos_json': True, 15:19:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:19:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:36 INFO - 'work_dir': 'build'} 15:19:36 INFO - ##### 15:19:36 INFO - ##### Running clobber step. 15:19:36 INFO - ##### 15:19:36 INFO - Running pre-action listener: _resource_record_pre_action 15:19:36 INFO - Running main action method: clobber 15:19:36 INFO - rmtree: /builds/slave/test-pgo/build 15:19:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:19:37 INFO - Running post-action listener: _resource_record_post_action 15:19:37 INFO - ##### 15:19:37 INFO - ##### Running read-buildbot-config step. 15:19:37 INFO - ##### 15:19:37 INFO - Running pre-action listener: _resource_record_pre_action 15:19:37 INFO - Running main action method: read_buildbot_config 15:19:37 INFO - Using buildbot properties: 15:19:37 INFO - { 15:19:37 INFO - "properties": { 15:19:37 INFO - "buildnumber": 1266, 15:19:37 INFO - "product": "firefox", 15:19:37 INFO - "script_repo_revision": "production", 15:19:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:19:37 INFO - "repository": "", 15:19:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:19:37 INFO - "buildid": "20151116133012", 15:19:37 INFO - "slavename": "talos-linux64-ix-008", 15:19:37 INFO - "pgo_build": "True", 15:19:37 INFO - "basedir": "/builds/slave/test-pgo", 15:19:37 INFO - "project": "", 15:19:37 INFO - "platform": "ubuntu64_hw", 15:19:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:19:37 INFO - "slavebuilddir": "test", 15:19:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:19:37 INFO - "branch": "mozilla-inbound", 15:19:37 INFO - "repo_path": "integration/mozilla-inbound", 15:19:37 INFO - "stage_platform": "linux64-pgo", 15:19:37 INFO - "builduid": "e287d31c7ae94c2fb4f126e732f15672", 15:19:37 INFO - "revision": "85237019374be7a67a2720a5913bfbde64012ebf" 15:19:37 INFO - }, 15:19:37 INFO - "sourcestamp": { 15:19:37 INFO - "repository": "", 15:19:37 INFO - "hasPatch": false, 15:19:37 INFO - "project": "", 15:19:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:19:37 INFO - "changes": [ 15:19:37 INFO - { 15:19:37 INFO - "category": null, 15:19:37 INFO - "files": [ 15:19:37 INFO - { 15:19:37 INFO - "url": null, 15:19:37 INFO - "name": "https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:19:37 INFO - } 15:19:37 INFO - ], 15:19:37 INFO - "repository": "", 15:19:37 INFO - "rev": "85237019374be7a67a2720a5913bfbde64012ebf", 15:19:37 INFO - "who": "sendchange", 15:19:37 INFO - "when": 1447715897, 15:19:37 INFO - "number": 6668684, 15:19:37 INFO - "comments": "", 15:19:37 INFO - "project": "", 15:19:37 INFO - "at": "Mon 16 Nov 2015 15:18:17", 15:19:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:19:37 INFO - "revlink": "", 15:19:37 INFO - "properties": [ 15:19:37 INFO - [ 15:19:37 INFO - "buildid", 15:19:37 INFO - "20151116133012", 15:19:37 INFO - "Change" 15:19:37 INFO - ], 15:19:37 INFO - [ 15:19:37 INFO - "builduid", 15:19:37 INFO - "e287d31c7ae94c2fb4f126e732f15672", 15:19:37 INFO - "Change" 15:19:37 INFO - ], 15:19:37 INFO - [ 15:19:37 INFO - "pgo_build", 15:19:37 INFO - "True", 15:19:37 INFO - "Change" 15:19:37 INFO - ] 15:19:37 INFO - ], 15:19:37 INFO - "revision": "85237019374be7a67a2720a5913bfbde64012ebf" 15:19:37 INFO - } 15:19:37 INFO - ], 15:19:37 INFO - "revision": "85237019374be7a67a2720a5913bfbde64012ebf" 15:19:37 INFO - } 15:19:37 INFO - } 15:19:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:19:37 INFO - Running post-action listener: _resource_record_post_action 15:19:37 INFO - ##### 15:19:37 INFO - ##### Running download-and-extract step. 15:19:37 INFO - ##### 15:19:37 INFO - Running pre-action listener: _resource_record_pre_action 15:19:37 INFO - Running main action method: download_and_extract 15:19:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:19:37 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')]} 15:19:37 INFO - https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/test_packages.json 15:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/test_packages.json 15:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:19:38 INFO - Downloaded 1302 bytes. 15:19:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:19:38 INFO - Using the following test package requirements: 15:19:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:19:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'jsshell-linux-x86_64.zip'], 15:19:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:19:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:19:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:19:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:19:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:19:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:19:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:19:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:19: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')]} 15:19:38 INFO - https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:19:39 INFO - Downloaded 22462395 bytes. 15:19:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:19:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:19:40 INFO - Return code: 0 15:19:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:19: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')]} 15:19:40 INFO - https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:19:43 INFO - Downloaded 22462395 bytes. 15:19:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:19:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:19:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:19:45 INFO - Return code: 0 15:19:45 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')]} 15:19:45 INFO - https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:19:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:19:46 INFO - Downloaded 11131693 bytes. 15:19:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:19:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:19:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:19:46 INFO - Return code: 0 15:19:46 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')]} 15:19:46 INFO - https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:19:48 INFO - Downloaded 57151829 bytes. 15:19:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:19:48 INFO - mkdir: /builds/slave/test-pgo/properties 15:19:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:19:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:19:48 INFO - Contents: 15:19:48 INFO - build_url:https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:19:48 INFO - Running post-action listener: _resource_record_post_action 15:19:48 INFO - Running post-action listener: set_extra_try_arguments 15:19:48 INFO - ##### 15:19:48 INFO - ##### Running populate-webroot step. 15:19:48 INFO - ##### 15:19:48 INFO - Running pre-action listener: _resource_record_pre_action 15:19:48 INFO - Running main action method: populate_webroot 15:19:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:19:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:19:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:19:48 INFO - '../fennec_ids.txt'], 15:19:48 INFO - 'tests': ['tcheck2']}, 15:19:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:19:48 INFO - '--tppagecycles', 15:19:48 INFO - '7'], 15:19:48 INFO - 'tests': ['tsvgm']}}, 15:19:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:19:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:19:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:19:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:19:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'tests': ['damp', 'tps']}, 15:19:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['damp', 'tps']}, 15:19:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:19:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:48 INFO - 'other': {'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'other_l64': {'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'other_nol64': {'tests': ['a11yr', 15:19:48 INFO - 'ts_paint', 15:19:48 INFO - 'tpaint', 15:19:48 INFO - 'sessionrestore', 15:19:48 INFO - 'sessionrestore_no_auto_restore']}, 15:19:48 INFO - 'svgr': {'tests': ['tsvgx', 15:19:48 INFO - 'tsvgr_opacity', 15:19:48 INFO - 'tart', 15:19:48 INFO - 'tscrollx', 15:19:48 INFO - 'cart']}, 15:19:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['tsvgx', 15:19:48 INFO - 'tsvgr_opacity', 15:19:48 INFO - 'tart', 15:19:48 INFO - 'tscrollx', 15:19:48 INFO - 'cart']}, 15:19:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'tests': ['tp5o']}, 15:19:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'talos_options': ['--e10s'], 15:19:48 INFO - 'tests': ['tp5o']}, 15:19:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'talos_options': ['--xperf_path', 15:19:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:48 INFO - 'tests': ['tp5n']}, 15:19:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:19:48 INFO - 'talos_options': ['--e10s', 15:19:48 INFO - '--xperf_path', 15:19:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:48 INFO - 'tests': ['tp5n']}}, 15:19:48 INFO - 'talos.zip': {'path': '', 15:19:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:19:48 INFO - Running post-action listener: _resource_record_post_action 15:19:48 INFO - ##### 15:19:48 INFO - ##### Running create-virtualenv step. 15:19:48 INFO - ##### 15:19:48 INFO - Running pre-action listener: _resource_record_pre_action 15:19:48 INFO - Running main action method: create_virtualenv 15:19:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:19:48 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 15:19:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:19:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:48 INFO - Using real prefix '/usr' 15:19:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:19:48 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:50 INFO - Installing pip.................done. 15:19:50 INFO - Return code: 0 15:19:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:19:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:19:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:19:50 INFO - Using env: {'DISPLAY': ':0', 15:19:50 INFO - 'HOME': '/home/cltbld', 15:19:50 INFO - 'LANG': 'en_US.UTF-8', 15:19:50 INFO - 'LANGUAGE': 'en_US:en', 15:19:50 INFO - 'LOGNAME': 'cltbld', 15:19:50 INFO - 'MAIL': '/var/mail/cltbld', 15:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:50 INFO - 'MOZ_NO_REMOTE': '1', 15:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:50 INFO - 'NO_EM_RESTART': '1', 15:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:50 INFO - 'SHELL': '/bin/bash', 15:19:50 INFO - 'SHLVL': '1', 15:19:50 INFO - 'TERM': 'linux', 15:19:50 INFO - 'TMOUT': '86400', 15:19:50 INFO - 'USER': 'cltbld', 15:19:50 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:50 INFO - '_': '/tools/buildbot/bin/python'} 15:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:51 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 15:19:51 INFO - Cleaning up... 15:19:51 INFO - Return code: 0 15:19:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:19: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')]} 15:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19: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')]} 15:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:19:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:19:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:19:51 INFO - Using env: {'DISPLAY': ':0', 15:19:51 INFO - 'HOME': '/home/cltbld', 15:19:51 INFO - 'LANG': 'en_US.UTF-8', 15:19:51 INFO - 'LANGUAGE': 'en_US:en', 15:19:51 INFO - 'LOGNAME': 'cltbld', 15:19:51 INFO - 'MAIL': '/var/mail/cltbld', 15:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:51 INFO - 'MOZ_NO_REMOTE': '1', 15:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:51 INFO - 'NO_EM_RESTART': '1', 15:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:51 INFO - 'SHELL': '/bin/bash', 15:19:51 INFO - 'SHLVL': '1', 15:19:51 INFO - 'TERM': 'linux', 15:19:51 INFO - 'TMOUT': '86400', 15:19:51 INFO - 'USER': 'cltbld', 15:19:51 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:51 INFO - '_': '/tools/buildbot/bin/python'} 15:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:51 INFO - Downloading/unpacking psutil>=0.7.1 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:19:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:19:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:53 INFO - Installing collected packages: psutil 15:19:53 INFO - Running setup.py install for psutil 15:19:53 INFO - building 'psutil._psutil_linux' extension 15:19:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:19:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:19:53 INFO - building 'psutil._psutil_posix' extension 15:19:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:19:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:19:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:53 INFO - Successfully installed psutil 15:19:53 INFO - Cleaning up... 15:19:53 INFO - Return code: 0 15:19:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:19:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:19:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:19:53 INFO - Using env: {'DISPLAY': ':0', 15:19:53 INFO - 'HOME': '/home/cltbld', 15:19:53 INFO - 'LANG': 'en_US.UTF-8', 15:19:53 INFO - 'LANGUAGE': 'en_US:en', 15:19:53 INFO - 'LOGNAME': 'cltbld', 15:19:53 INFO - 'MAIL': '/var/mail/cltbld', 15:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:53 INFO - 'MOZ_NO_REMOTE': '1', 15:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:53 INFO - 'NO_EM_RESTART': '1', 15:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:53 INFO - 'SHELL': '/bin/bash', 15:19:53 INFO - 'SHLVL': '1', 15:19:53 INFO - 'TERM': 'linux', 15:19:53 INFO - 'TMOUT': '86400', 15:19:53 INFO - 'USER': 'cltbld', 15:19:53 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:53 INFO - '_': '/tools/buildbot/bin/python'} 15:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:19:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:19:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:19:55 INFO - Installing collected packages: mozsystemmonitor 15:19:55 INFO - Running setup.py install for mozsystemmonitor 15:19:55 INFO - Successfully installed mozsystemmonitor 15:19:55 INFO - Cleaning up... 15:19:55 INFO - Return code: 0 15:19:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:19:55 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')]} 15:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:55 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')]} 15:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:19:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:19:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:19:55 INFO - Using env: {'DISPLAY': ':0', 15:19:55 INFO - 'HOME': '/home/cltbld', 15:19:55 INFO - 'LANG': 'en_US.UTF-8', 15:19:55 INFO - 'LANGUAGE': 'en_US:en', 15:19:55 INFO - 'LOGNAME': 'cltbld', 15:19:55 INFO - 'MAIL': '/var/mail/cltbld', 15:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:55 INFO - 'MOZ_NO_REMOTE': '1', 15:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:55 INFO - 'NO_EM_RESTART': '1', 15:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:55 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:55 INFO - 'SHELL': '/bin/bash', 15:19:55 INFO - 'SHLVL': '1', 15:19:55 INFO - 'TERM': 'linux', 15:19:55 INFO - 'TMOUT': '86400', 15:19:55 INFO - 'USER': 'cltbld', 15:19:55 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:55 INFO - '_': '/tools/buildbot/bin/python'} 15:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19: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 15:19:57 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:19:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 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 15:19:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:19:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:19:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:58 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 15:19:58 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 15:19:58 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 15:19:58 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 15:19:58 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 15:19:58 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 15:19:58 INFO - Downloading docopt-0.6.1.tar.gz 15:19:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:19:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:58 INFO - Running setup.py install for blobuploader 15:19:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:19:58 INFO - Running setup.py install for requests 15:19:58 INFO - Running setup.py install for docopt 15:19:58 INFO - Successfully installed blobuploader requests docopt 15:19:58 INFO - Cleaning up... 15:19:58 INFO - Return code: 0 15:19:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:19:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:19:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:19:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:19:58 INFO - Using env: {'DISPLAY': ':0', 15:19:58 INFO - 'HOME': '/home/cltbld', 15:19:58 INFO - 'LANG': 'en_US.UTF-8', 15:19:58 INFO - 'LANGUAGE': 'en_US:en', 15:19:58 INFO - 'LOGNAME': 'cltbld', 15:19:58 INFO - 'MAIL': '/var/mail/cltbld', 15:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:58 INFO - 'MOZ_NO_REMOTE': '1', 15:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:58 INFO - 'NO_EM_RESTART': '1', 15:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:19:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:19:58 INFO - 'SHELL': '/bin/bash', 15:19:58 INFO - 'SHLVL': '1', 15:19:58 INFO - 'TERM': 'linux', 15:19:58 INFO - 'TMOUT': '86400', 15:19:58 INFO - 'USER': 'cltbld', 15:19:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:58 INFO - '_': '/tools/buildbot/bin/python'} 15:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:19:59 INFO - Running setup.py (path:/tmp/pip-eqvG5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:19:59 INFO - Running setup.py (path:/tmp/pip-k312nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:19:59 INFO - Running setup.py (path:/tmp/pip-dyg0Ez-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:19:59 INFO - Running setup.py (path:/tmp/pip-ozSQX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:19:59 INFO - Running setup.py (path:/tmp/pip-VmvLXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:19:59 INFO - Running setup.py (path:/tmp/pip-xTNmKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:19:59 INFO - Running setup.py (path:/tmp/pip-7JhE60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:19:59 INFO - Running setup.py (path:/tmp/pip-2SJEx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:19:59 INFO - Running setup.py (path:/tmp/pip-oYiSIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:19:59 INFO - Running setup.py (path:/tmp/pip-dcLzrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:19:59 INFO - Running setup.py (path:/tmp/pip-WOFMpw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:19:59 INFO - Running setup.py (path:/tmp/pip-kMACIx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:20:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:20:00 INFO - Running setup.py (path:/tmp/pip-wn3sdP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:20:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:20:00 INFO - Running setup.py (path:/tmp/pip-i4EG1h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:20:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:20:00 INFO - Running setup.py (path:/tmp/pip-aculXK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:20:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:20:00 INFO - Running setup.py (path:/tmp/pip-JW9BgL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:20:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:20:00 INFO - Running setup.py (path:/tmp/pip-Mz70Ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:20:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:00 INFO - Running setup.py install for manifestparser 15:20:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:20:00 INFO - Running setup.py install for mozcrash 15:20:00 INFO - Running setup.py install for mozdebug 15:20:00 INFO - Running setup.py install for mozdevice 15:20:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:20:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:20:00 INFO - Running setup.py install for mozfile 15:20:00 INFO - Running setup.py install for mozhttpd 15:20:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozinfo 15:20:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozInstall 15:20:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozleak 15:20:01 INFO - Running setup.py install for mozlog 15:20:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for moznetwork 15:20:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozprocess 15:20:01 INFO - Running setup.py install for mozprofile 15:20:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozrunner 15:20:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:20:01 INFO - Running setup.py install for mozscreenshot 15:20:01 INFO - Running setup.py install for moztest 15:20:02 INFO - Running setup.py install for mozversion 15:20:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:20:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:02 INFO - Cleaning up... 15:20:02 INFO - Return code: 0 15:20:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:20:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:20:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:20:02 INFO - Using env: {'DISPLAY': ':0', 15:20:02 INFO - 'HOME': '/home/cltbld', 15:20:02 INFO - 'LANG': 'en_US.UTF-8', 15:20:02 INFO - 'LANGUAGE': 'en_US:en', 15:20:02 INFO - 'LOGNAME': 'cltbld', 15:20:02 INFO - 'MAIL': '/var/mail/cltbld', 15:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:02 INFO - 'MOZ_NO_REMOTE': '1', 15:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:02 INFO - 'NO_EM_RESTART': '1', 15:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:20:02 INFO - 'PWD': '/builds/slave/test-pgo', 15:20:02 INFO - 'SHELL': '/bin/bash', 15:20:02 INFO - 'SHLVL': '1', 15:20:02 INFO - 'TERM': 'linux', 15:20:02 INFO - 'TMOUT': '86400', 15:20:02 INFO - 'USER': 'cltbld', 15:20:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:02 INFO - '_': '/tools/buildbot/bin/python'} 15:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:20:02 INFO - Running setup.py (path:/tmp/pip-HHBBsr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:20:02 INFO - Running setup.py (path:/tmp/pip-B4PlTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:20:02 INFO - Running setup.py (path:/tmp/pip-LnGlfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:20:02 INFO - Running setup.py (path:/tmp/pip-MhTuQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:20:02 INFO - Running setup.py (path:/tmp/pip-K1F6L9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:20:02 INFO - Running setup.py (path:/tmp/pip-zc708P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:20:02 INFO - Running setup.py (path:/tmp/pip-XYhP6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:20:02 INFO - Running setup.py (path:/tmp/pip-T7DJ23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:20:02 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)) 15:20:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:20:02 INFO - Running setup.py (path:/tmp/pip-frWvKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:20:03 INFO - Running setup.py (path:/tmp/pip-_QNjiA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:20:03 INFO - Running setup.py (path:/tmp/pip-kzuzKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:20:03 INFO - Running setup.py (path:/tmp/pip-52NIYG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:20:03 INFO - Running setup.py (path:/tmp/pip-JM3rjD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:20:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:20:03 INFO - Running setup.py (path:/tmp/pip-MwNZK4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:20:03 INFO - Running setup.py (path:/tmp/pip-DML8Lb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:20:03 INFO - Running setup.py (path:/tmp/pip-PfjesZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:20:03 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)) 15:20:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:20:03 INFO - Running setup.py (path:/tmp/pip-CG0nGj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:20:03 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)) 15:20:03 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:03 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:20:03 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)) 15:20:03 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:20:03 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:20:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:05 INFO - Downloading blessings-1.5.1.tar.gz 15:20:05 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:20:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:05 INFO - Installing collected packages: blessings 15:20:05 INFO - Running setup.py install for blessings 15:20:05 INFO - Successfully installed blessings 15:20:05 INFO - Cleaning up... 15:20:05 INFO - Return code: 0 15:20:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:20:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:20:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:20:05 INFO - Reading from file tmpfile_stdout 15:20:05 INFO - Current package versions: 15:20:05 INFO - argparse == 1.2.1 15:20:05 INFO - blessings == 1.5.1 15:20:05 INFO - blobuploader == 1.2.4 15:20:05 INFO - docopt == 0.6.1 15:20:05 INFO - manifestparser == 1.1 15:20:05 INFO - mozInstall == 1.12 15:20:05 INFO - mozcrash == 0.16 15:20:05 INFO - mozdebug == 0.1 15:20:05 INFO - mozdevice == 0.47 15:20:05 INFO - mozfile == 1.2 15:20:05 INFO - mozhttpd == 0.7 15:20:05 INFO - mozinfo == 0.9 15:20:05 INFO - mozleak == 0.1 15:20:05 INFO - mozlog == 3.0 15:20:05 INFO - moznetwork == 0.27 15:20:05 INFO - mozprocess == 0.22 15:20:05 INFO - mozprofile == 0.27 15:20:05 INFO - mozrunner == 6.11 15:20:05 INFO - mozscreenshot == 0.1 15:20:05 INFO - mozsystemmonitor == 0.0 15:20:05 INFO - moztest == 0.7 15:20:05 INFO - mozversion == 1.4 15:20:05 INFO - psutil == 3.1.1 15:20:05 INFO - requests == 1.2.3 15:20:05 INFO - wsgiref == 0.1.2 15:20:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fc2aee65c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cae3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, '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': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', '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 15:20:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:20:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:20:05 INFO - Using env: {'DISPLAY': ':0', 15:20:05 INFO - 'HOME': '/home/cltbld', 15:20:05 INFO - 'LANG': 'en_US.UTF-8', 15:20:05 INFO - 'LANGUAGE': 'en_US:en', 15:20:05 INFO - 'LOGNAME': 'cltbld', 15:20:05 INFO - 'MAIL': '/var/mail/cltbld', 15:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:05 INFO - 'MOZ_NO_REMOTE': '1', 15:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:05 INFO - 'NO_EM_RESTART': '1', 15:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:20:05 INFO - 'PWD': '/builds/slave/test-pgo', 15:20:05 INFO - 'SHELL': '/bin/bash', 15:20:05 INFO - 'SHLVL': '1', 15:20:05 INFO - 'TERM': 'linux', 15:20:05 INFO - 'TMOUT': '86400', 15:20:05 INFO - 'USER': 'cltbld', 15:20:05 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:05 INFO - '_': '/tools/buildbot/bin/python'} 15:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:05 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 1)) 15:20:05 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 2)) 15:20:05 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 3)) 15:20:05 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 4)) 15:20:05 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 5)) 15:20:05 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 6)) 15:20:05 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 7)) 15:20:05 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 8)) 15:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:20:05 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:20:05 INFO - Cleaning up... 15:20:05 INFO - Return code: 0 15:20:05 INFO - Running post-action listener: _resource_record_post_action 15:20:05 INFO - Running post-action listener: _start_resource_monitoring 15:20:06 INFO - Starting resource monitoring. 15:20:06 INFO - ##### 15:20:06 INFO - ##### Running install step. 15:20:06 INFO - ##### 15:20:06 INFO - Running pre-action listener: _resource_record_pre_action 15:20:06 INFO - Running main action method: install 15:20:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:20:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:20:06 INFO - Reading from file tmpfile_stdout 15:20:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:20:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:20:06 INFO - Reading from file tmpfile_stdout 15:20:06 INFO - Output received: 15:20:06 INFO - Usage: mozinstall [options] installer 15:20:06 INFO - Options: 15:20:06 INFO - -h, --help show this help message and exit 15:20:06 INFO - -d DEST, --destination=DEST 15:20:06 INFO - Directory to install application into. [default: 15:20:06 INFO - "/builds/slave/test-pgo"] 15:20:06 INFO - --app=APP Application being installed. [default: firefox] 15:20:06 INFO - mkdir: /builds/slave/test-pgo/build/application 15:20:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:20:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:20:20 INFO - Reading from file tmpfile_stdout 15:20:20 INFO - Output received: 15:20:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:20:20 INFO - Running post-action listener: _resource_record_post_action 15:20:20 INFO - ##### 15:20:20 INFO - ##### Running run-tests step. 15:20:20 INFO - ##### 15:20:20 INFO - Running pre-action listener: _resource_record_pre_action 15:20:20 INFO - Running main action method: run_tests 15:20:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:20:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:20:20 INFO - Python 2.7.3 15:20:20 INFO - Return code: 0 15:20:20 INFO - grabbing minidump binary from tooltool 15:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:20 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 0x2d378c0>, '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 0x2ce4420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce48b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:20:20 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 15:20:20 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 15:20:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:20:20 INFO - Return code: 0 15:20:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:20:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:20:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:20:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:20:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:20:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:20:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 15:20:20 INFO - Using env: {'DISPLAY': ':0', 15:20:20 INFO - 'HOME': '/home/cltbld', 15:20:20 INFO - 'LANG': 'en_US.UTF-8', 15:20:20 INFO - 'LANGUAGE': 'en_US:en', 15:20:20 INFO - 'LOGNAME': 'cltbld', 15:20:20 INFO - 'MAIL': '/var/mail/cltbld', 15:20:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:20:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:20 INFO - 'MOZ_NO_REMOTE': '1', 15:20:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:20:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:20 INFO - 'NO_EM_RESTART': '1', 15:20:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:20:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:20:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:20:20 INFO - 'SHELL': '/bin/bash', 15:20:20 INFO - 'SHLVL': '1', 15:20:20 INFO - 'TERM': 'linux', 15:20:20 INFO - 'TMOUT': '86400', 15:20:20 INFO - 'USER': 'cltbld', 15:20:20 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1447715883.646-617506730', 15:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:20 INFO - '_': '/tools/buildbot/bin/python'} 15:20:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 15:20:21 INFO - mozversion INFO | application_buildid: 20151116133012 15:20:21 INFO - mozversion INFO | application_changeset: 85237019374be7a67a2720a5913bfbde64012ebf 15:20:21 INFO - mozversion INFO | application_display_name: Nightly 15:20:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:20:21 INFO - mozversion INFO | application_name: Firefox 15:20:21 INFO - mozversion INFO | application_remotingname: firefox 15:20:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:20:21 INFO - mozversion INFO | application_vendor: Mozilla 15:20:21 INFO - mozversion INFO | application_version: 45.0a1 15:20:21 INFO - mozversion INFO | platform_buildid: 20151116133012 15:20:21 INFO - mozversion INFO | platform_changeset: 85237019374be7a67a2720a5913bfbde64012ebf 15:20:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:20:21 INFO - mozversion INFO | platform_version: 45.0a1 15:20:21 INFO - 2015-11-16 15:20:21,044 DEBUG : using testdate: 1447716021 15:20:21 INFO - 2015-11-16 15:20:21,044 DEBUG : actual date: 1447716021 15:20:21 INFO - 2015-11-16 15:20:21,091 INFO : starting webserver on 'localhost:32983' 15:20:21 INFO - 2015-11-16 15:20:21,092 INFO : Starting test suite talos-linux64-ix-008 15:20:21 INFO - 2015-11-16 15:20:21,092 INFO : Starting test dromaeo_css 15:20:21 INFO - 2015-11-16 15:20:21,092 DEBUG : operating with platform_type : linux_ 15:20:21 INFO - 2015-11-16 15:20:21,093 INFO : Initialising browser for dromaeo_css test... 15:20:21 INFO - 2015-11-16 15:20:21,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCW43dj/profile http://localhost:32983/getInfo.html 15:20:25 INFO - 2015-11-16 15:20:25,774 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:20:25 INFO - 2015-11-16 15:20:25,774 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:20:25 INFO - 2015-11-16 15:20:25,774 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:20:25 INFO - 2015-11-16 15:20:25,774 DEBUG : BROWSER_OUTPUT: __metrics 15:20:25 INFO - 2015-11-16 15:20:25,911 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:27 INFO - 2015-11-16 15:20:27,123 INFO : Browser initialized. 15:20:27 INFO - 2015-11-16 15:20:27,123 INFO : Running cycle 1/1 for dromaeo_css test... 15:20:27 INFO - 2015-11-16 15:20:27,124 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCW43dj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:20:38 INFO - 2015-11-16 15:20:38,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 142258176 15:20:38 INFO - 2015-11-16 15:20:38,896 DEBUG : BROWSER_OUTPUT: 15:21:30 INFO - 2015-11-16 15:21:30,435 DEBUG : BROWSER_OUTPUT: 1447716090434 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] 15:23:38 INFO - 2015-11-16 15:23:38,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32983/tests/dromaeo/cssquery-ext.html) 15:23:39 INFO - 2015-11-16 15:23:39,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 228573184 15:23:39 INFO - 2015-11-16 15:23:39,759 DEBUG : BROWSER_OUTPUT: 15:26:42 INFO - 2015-11-16 15:26:42,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-ext.html (next: http://localhost:32983/tests/dromaeo/cssquery-jquery.html) 15:26:42 INFO - 2015-11-16 15:26:42,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 214773760 15:26:42 INFO - 2015-11-16 15:26:42,619 DEBUG : BROWSER_OUTPUT: 15:29:44 INFO - 2015-11-16 15:29:44,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32983/tests/dromaeo/cssquery-mootools.html) 15:29:45 INFO - 2015-11-16 15:29:45,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 203509760 15:29:45 INFO - 2015-11-16 15:29:45,157 DEBUG : BROWSER_OUTPUT: 15:32:47 INFO - 2015-11-16 15:32:47,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32983/tests/dromaeo/cssquery-prototype.html) 15:32:47 INFO - 2015-11-16 15:32:47,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 199081984 15:32:47 INFO - 2015-11-16 15:32:47,683 DEBUG : BROWSER_OUTPUT: 15:35:50 INFO - 2015-11-16 15:35:50,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32983/tests/dromaeo/cssquery-yui.html) 15:35:50 INFO - 2015-11-16 15:35:50,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 202743808 15:35:50 INFO - 2015-11-16 15:35:50,715 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/dromaeo/cssquery-yui.html (next: http://localhost:32983/tests/dromaeo/cssquery-dojo.html) 15:38:53 INFO - 2015-11-16 15:38:53,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 288956416 15:38:53 INFO - 2015-11-16 15:38:53,304 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,305 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:38:53 INFO - 2015-11-16 15:38:53,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:38:53 INFO - 2015-11-16 15:38:53,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:38:53 INFO - 2015-11-16 15:38:53,305 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:38:53 INFO - 2015-11-16 15:38:53,305 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3159.5576619273297;3221.1463962050047;3252.7560432967534;3262.347530493902;3282.5568548245988;5160.122779127548;5303.734813259341;5411.107167317393;5430.837074887755;5447.645903016301;5348.304720386354;5359.38367087785;5436.293281873361;5502.972485137579;5514.91727624086;4908;4932.630052746041;4949.826756063539;4974;5000.524950129732;5020.347354843865;5079.492050794928;5085.5423011928915;5135.614828887829;5143.09995750744;4760.500147484516;4850.054239423313;4866.489018653044;4964.776585053682;4978.6017118630425;4988.7505624718615;5001.049800537922;5006.674566153189;5009.273655319958;5044.419891712427;4788;4987.775550100254;4996.2755400467095;5014.674046187022;5044.192929131322;5097.133487307166;5124.743762811881;5186.222066689989;5212.1921102228835;5227.294315267428;5838.1534677471955;5919.348871624118;5928.110783382484;5933.614315069507;5935.49548288396;5724.398938111522;5866.325372582122;5952.404759524056;5967.910481342783;5968.253968253968;5382.650127741724;5442.374126975409;5464.207689884945;5467.808626698126;5509.972450137724;5973.910391344133;5978.910316345258;6000.549958753111;6049.274087109575;6052.878942421215;5611.691356975405;5765.85585360361;5803.129530570363;5808;5851.531877449794;5809;5889.734961926723;5890.057590785454;5890.970545147333;5918.7928422505;5767.307923049177;5897.085951677497;5921.970390148022;5927.4665280125;5935.940640593625;5714.828555143269;5744.080947048452;5837.9124313135335;5912.645241285537;5927.614705044159;4543.636509079266;4544.02303504748;4545.0909818036525;4551.8179272829375;4584.426946631671;4039.4142849287277;4039.5758445362812;4048.7570745755347;4051.4125451809323;4089.2434899543678;5373.435789242151;5494.395616482184;5498.037843377393;5601.131824567198;5624.325080990226;5905.911411328833;5967.8209653710455;5993.550483713651;5994.340622531605;5995.940040599626;5646.407127251579;5649.887002260014;5661.34894487131;5668.914966275509;5669.914951275734;4944.678595891256;4985.252212168204;5027.472115427828;5079.822206222764;5107.719075450812;6045.607035542764;6053.727582258809;6053.939460605426;6059.242594675666;6059.515238780887;5772.884542309214;5873.911891321719;5877.23595932526;5885.793997210077;5888.735006924613;5955.196048533566;6016.067509536029;6068.605540639845;6103;6103.938960610515;5664.0937450007805;5669.4047125051275;5675.432456754292;5688.800891968761;5784.4504772046585;5763.51010164124;5771.249737534094;5772.134179873053;5780.364159942487;5781.4507621775865;5582.748776304995;5686.2607860977805;5785;5787.508061814793;5839.15332276809;5801.274840644919;5824.271966004249;5835.883282334415;5837.854053648693;5840.415958404125;5451.3458384994055;5555.2778138841695;5713.143028545585;5717.799877004285;5730.627509211888;5707.68607726579;5791.652500849962;5799.4780469757925;5817.5345972321265;5837.0368889132815;5598.048331783688;5627.690477023803;5629.831105066854;5643.181738647955;5689.487946084872 15:38:53 INFO - 2015-11-16 15:38:53,306 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.2757827128964;587.5299760191842;588.3733823477993;594.5124997502047;594.7056207177446;31727.841360793194;32340.897841640308;32480.350392992157;40294.798526007406;40570;43822;44285.114297714026;44396;44397.77801110998;44460.3330950036;8638.740837774876;8831.47011179328;8852.645894164258;8854.778630534223;8855.203031727144;7896.960515197416;8050.677972881078;8065.2741253287195;10209.081182693557;10466.529006194702;10109.14072303855;10204.336718113298;10216.335938163995;10223.591056357736;10224.386536807779;10038.899611003906;10069.647562335284;10073.798524029478;10086.596536138546;10129.442880641562;7856.842863142705;8055.637496312622;10329.896701033043;10720.571177152904;10726.946365268202;39802.40296395557;40195.799021005;40243.597564024276;40265.79867100646;40291.56063931361;2910.57796619489;2915.227464721829;2950.439416510856;3014.9246268843235;3355.882544110969;30582.69417305843;30789.230269243224;31280.843595782102;31525.684743152506;32052.519212211835;3490.8080055596934;3495.615482296945;3521.102118959649;3602.5136606558303;3608.675219230282;273473;274386;274990;275578;275579;55811.44188558144;57094;57145;58883.41116588865;59180.40819591749;60812.39187608156;61198.082028769604;61227;61249.38750612526;61335.693321533996;13281.601551953458;13372.799408008888;13475.528356507672;13494.595162145151;13505.52730654442;9960.252981026451;10006.09945104944;10042.598296068076;10115.494225288707;10122.645707400354;19455.513612159808;19547.21811127539;19557.31549395764;19569.119389627216;19582.608347833248;8034.959825200836;8058.476199047043;8137.837243255101;8177.713780017671;8220.547869867214;918.9816203675889;926.8887733472027;997.2719914462338;1006.3244697578596;1056.3609016544879;28105.859470702515;28634.85682571574;28706.71293287082;28816.135515934555;28861.42277154445;1023.4729114506035;1026.8870424253475;1081.8864019277862;1088.2219213262556;1091.170710260192;14456.494022709154;15001.17493537844;15099.245037748069;15372.231388430533;15376.769348459782;379272;383290;383689;386267;387872;53132;53498.46501534935;53683.19475207875;53699;53746.73126634342;1158.5423757615526;1368.5141774670049;1372.8009438631543;1394.2331717555303;1399.069618703571;23190.884045579664;30276.84861575678;30689.386212276077;30698.386032279675;31340.373192536477;50635;51330.23004654858;51341.48658513367;51396.22905656343;51429;303229;306705;307178;418540;424591;32549.18627034343;32807.34385312328;32858.835705821315;33224.83387583047;33379.499307510894;41354.1729165409;42862.78568607137;42995.140097197254;43218.783906080265;43758.56241437545;35979.82010089933;36113.81943090268;36297.27405451929;36307.818460907525;37362.43956340711;36210;36238;36360;36366.63633363633;36837;34848;35921.64078359288;35971.64028359787;35974.820125899205;36001.27997440089;29697.554536681535;32879;33054.834725826215;33224;33379.33241335208;25010.373495843363;25577.360565986;26990.460190796468;27364.179074627795;27531.31171720723 15:38:53 INFO - 2015-11-16 15:38:53,308 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.5466892360851;335.11696679250184;337.87667501362006;344.19115079563045;353.18414462591414;14664.926675366609;15127.470538531154;17054;17119.57201069974;17629.559261018465;14628.561143165696;16575;16683.66632667349;16766.497005089837;17687.29250829965;5218.895622087565;5321.095413779667;5328.973355133238;5329.907368989348;5331;3866.3427217373114;4034.5763694812063;5287.894242115155;5304.257403963448;5651.124075768263;5763.962486752383;5788.536917046647;5791.681457519835;5795.623284486495;5800.303963524383;5647.3505546862225;5730.770769169249;5796.043652797283;5808.361080281165;5811.4479124483105;5045.268436076748;5047.47001564834;5055.823046193365;5055.898882022376;5056.696598204119;20275.175234228842;20384;20646.483837904023;20791.16835326585;20799.272025479037;2157.6871353653632;2160.7299087614047;2191.6822060801096;2352.2002519143402;2513.949721005588;8853.24747396472;9158.587863546156;9249.35254532183;13133.60599182026;13641.113327633771;1630.8206097329285;1647.9176041198011;1654.0654530190404;1673.0380031481945;1730.3338214787398;57795.71102144462;58019.41980580182;58311;60638;63245.36754632441;6675.86648267032;6753.864922701617;6761.425278851254;6837.145356830396;6868.450523958171;8116.959415203004;8132.918670813335;8134.796630084295;8141.470804397695;8142.348612111017;5103.979204159183;5122.487751224922;5128.230765385222;5152.3044389007755;5156.871078222999;5138.486151384906;5196.45437229093;5202.3497062867145;5226.686398816083;5236.764345604381;3082.583851180062;3137.796043257181;3144.591203143577;3149.5433162191352;3157.542156387357;1073.726199819041;1096.8793432722555;1125.58915995661;1135.7160709822545;1161.3960740415105;474.3927772451268;480.31555034077;498.4541926590378;512.0501469773517;515.1294312611749;11260.718482038015;11300.095992320594;11356;11356.602518911799;11945.065474289386;412.1962173761118;480.3011618095662;486.12497504491773;488.6994498383469;495.37087898368867;4630.4443466784205;5953.702314884238;6018.699065046818;6154.446099851035;6226.066090086523;405125;405638;406789.2531821497;410158;512845;78341.60829195818;79155.20844791594;80624;81177.18822811815;82188;512.8794733237686;520.7344254430268;522.3027258609723;523.5602094240855;523.9345081864767;10380.740481488023;10822.296550724177;10882.075023623082;10906.61826836057;10994.395308257803;31631.683683162875;32588.511172332906;32911.67088329086;33394.99815005554;33520.49719254165;38931.416028760155;39152.608473916036;39735.20529589334;40020.599794002854;40328.79835600803;6515.250746164252;6580.309067547839;6666.600003999775;6671.066050752802;6676.232233293039;11897.107716921439;12030.15788894769;12162.817557736818;12209.938950305546;12239.326837023693;10365.792684146125;10373.792524149323;10511.789764204826;10533.157347412342;10695.197860160675;10114.747131321776;10281.177505799667;10410.68767936963;10532.473376331305;10712.571497140027;8384.32925365957;8464.703735369232;10650.680479585624;10698.197635177237;10908.945455272673;5861.413858614104;6081.969590152198;6710.16122984627;6725.663716814238;6737.461003119641;9912.454814984956;10461.267711260443;10566.735831603964;10876;10917.181211409017 15:38:53 INFO - 2015-11-16 15:38:53,309 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1147.414818442594;1468.2511918921355;1474.1670955909904;1689.7465380192973;1762.0396883698384;6521.576097553661;7237.697214501388;7372.225916278794;7384.963075184623;7388.408927285817;7514.924850751491;7614.619269036553;7617.352525035379;7625.809354766134;7638.083429988395;1958.2167133146713;2003.388966365258;2242.1703969531295;2254.4589298568308;2275.567642147995;2286.874221917794;2289.69089172962;2293.289080385086;2294.1167650454613;2294.1511640692966;2221.2669818959703;2269.954600907981;2270.909163633453;2272.4432514034;2275.8179345652306;1994.0627904884682;2038.6636205026152;2225.1766846266905;2263.3888850010403;2267.716535433071;2245.5059886825034;2246.9325920222254;2270.545890821842;2272.818174546049;2314.7916687498036;7477.551346919202;7488.213737557532;7572.848543029108;7579.279968402993;7595.202503737083;4533.320001999694;4626.21354369758;4629.65277604181;4631.16639004979;4641.605463535603;2986.1788008297676;3027.63668359796;3050.5881705969855;3078.291992841637;3111.844407779602;976.9218462522981;985.7781999050156;1015.1472762879217;1031.9742006449824;1039.7920415916847;10684.252102352839;10705.518251678694;10710.785784284271;10732.785344293148;10736.892631073668;4095.447114639545;4155.709100362946;4180.143070670505;4291.871243862689;4297.39836422901;9123.224525915371;9127.543622818832;9127.634894604274;9141.634334626673;9148;4638.1883170445035;4638.304254361873;4658.440987081504;4659.65052621048;4663.020765639254;4236.915261694749;4259.041715614024;4263.893402664959;4270.188664153801;4270.615644592001;3709.1839795245005;3748.9250214995545;3755.6432138946757;3770.1894092770185;3790.0714324990554;1203.8735932727113;1213.9878601214052;1219.469530754125;1221.82283568882;1225.546547777328;966.1111777165025;1263.5451237554473;1274.5539061328461;1298.9220646761225;1306.510058727977;6482.319356467598;6999.23008469068;7371.8157046074275;7394.778156655201;7402;639.0573903492311;648.4876947211744;649.399305642279;656.5633853487473;657.1293036726356;5685.800996965087;5742.16738572913;5763.077907534858;5773.566982476331;5786.508146807484;9359.298052645943;9538.52307384628;9547.093026162504;9683.854742178873;9701.126898579161;9268;9437.292203084797;9500.144986951207;9552.235821134293;9571.856422153534;7088.432925365958;7157.391621712213;7203.819904502325;7213.639318034077;7219.133703955454;6383.648899310582;6524.902126468011;6531.281559028408;6555.541112122106;6558.606483610999;8242.464239824392;8357.95821020891;8418.400503904239;8434.662613495637;8438.240558349778;8449.66201351939;8522.914770852212;8685.696000639948;8694.34792390586;8710.433821801562;6654.933450665431;6698.531102822755;6711.362420570038;6714.798556043326;6714.966425167843;7407;7438.814029649302;7496.137944136276;7497.962510187414;7499.287567681062;7008.859822803617;7056.470764692566;7066.8233294166;7087.964560177166;7175.354218120394;6881.552699074544;6911.550749201286;6956.40870526011;7009.0537777399395;7093.113360829896;6075.058365953284;6226;7067.71729130829;7115.359617634438;7121.67952442131;6068.4841788448475;6216.222972128484;6273.62358258506;6287.46556542699;6288.905666415099;6088.452039316483;6274.027525733519;6301.243850737757;6307.337729538516;6320.778772742932 15:38:53 INFO - 2015-11-16 15:38:53,310 DEBUG : BROWSER_OUTPUT: |4;prototype.html;313.5359667691816;319.6771261026363;320.858822118268;322.03871443740445;324.5035096302658;5863.208466856973;5916.704164791765;5991.670458124801;5997.730102145409;6009.1286763419275;5763.82708518744;5892.2340095787595;5928.6739229342365;5936.940630593704;5937.435943585363;4378.62781663559;4495.595396414322;4525.479569849468;4533.410656614652;4540.364348991144;4455.220336441126;4511;4519.367288579601;4531.210171982065;4531.977340113295;4468.798904049309;4469.374287599739;4476.194285028693;4477.619402350804;4488.8877778055485;4472.552744725518;4484.439445069366;4491.640668746492;4494.505604383498;4540.29625408059;3889.9027524311837;3971.4241434992055;3972.086420123359;3978.76127432355;3980.7014473914574;5591.021571225019;5612.915806262909;5622.409646987048;5634.859128521779;5641.5204707599905;5295.285136506561;5298.602604804655;5299.894002119974;5300.390455097675;5305.098133317345;6054;6169.413905678954;6217.56477046607;6328.082428047954;6344.936550634481;4340.457442819647;4357.215701173787;4365.603007037749;4371.300591905312;4378.277584198635;6564.081028655992;6568.1789776277965;6569.901451478184;6578.3421657834315;6584.111144995412;4381.474223093249;4449.110177964355;4460.286354183315;4488.102379524108;4495.64034877209;4515.480719717275;4523.479799822997;4526.321051842184;4537.77311134442;4539.568740969603;5260.684358938476;5262.815801447007;5267.31524901768;5268.051750684914;5268.631195816256;6379.330170332141;6383.904241436382;6386.521010924199;6391.2330520337855;6397.264314603787;1580.20199799103;1597.8641815445817;1617.6117731744296;1620.5705488045678;1620.6272557311884;1054.6941386997837;1081.9242653014214;1083.9891601084046;1087.0922779479224;1088.455772113943;6192.535559833031;6194.876102477925;6198.194234749454;6206.317305096436;6209.410106039919;6541.47668186544;6542.378474044958;6548.9017664735065;6553.180852393451;6554.246261679872;6071.119687645267;6161.045038019114;6169.475594574512;6180.938190618126;6186.133941248228;3525.1715846775987;3548.7693299935936;3552.520409744703;3556.608773035016;3557.0573797943566;6749.561278516979;6814.761483348059;6815.114035175495;6815.454763618898;6816.546043424363;6711.630860302633;6733.091032710619;6739.157605299338;6740.39336459721;6748.662566871637;6706.295838936939;6869.0383346331555;6874.381305682413;6886.51794374399;6887.173539175331;6368.554201206057;6446.8388290293115;6520.836979075561;6648.966755166387;6657.633830139389;6546.0508226307875;6559.409653131241;6574.145361103026;6576;6583.769568065095;6764.458843292623;6867.3476019778045;6870.038194652652;6887.552309099892;6891.138607674041;4434.445694288214;4461.866144015685;4473.955260447354;4474.082813023258;4474.821007159677;6606.504512161511;6612.272650008399;6612.867742645024;6616.206055273398;6619.735210591522;6345.809625711236;6399.168108145911;6403;6403.775867844603;6408.166938297992;6284.245890492987;6416.550841441241;6418.133551970424;6423.004434312689;6430.614163150039;6278.309385967631;6293.118963345044;6295.842603934938;6306.369363063657;6306.527010474325;6340.4927605792345;6445.742170313135;6451.806445806634;6455.225372955276;6456.063870738622;6263.404976527223;6300.873982520232;6306.810795676137;6311.652859092794;6317.842053948688 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.2934741889562;799.1608810748714;855.3841234311294;884.1379654836539;885.8494056010478;13561.25413102279;13788.103773254732;13804.861951380495;13811.79282310765;13846.10000349979;11730.120240981918;12359.134860559765;12379.195352302117;12436;12529;825.1006403020706;840.1052878684212;840.2773614691391;840.3403328387217;841.2386789955101;829.4318391901537;829.8132920092961;837.137748119435;837.7026155714725;838.2162677896156;875.1511034296722;876.8202518483696;877.749841295231;877.7673916412156;877.929765618749;873.0178549132227;873.5850471026275;873.8995015573195;874.8512752832033;878.9736307910773;640.8782331357074;640.8814369341686;641.1408712325459;643.5302229372537;645.6416688737748;12665.176763510435;12821.871781282254;12824.294663793487;12836.679083022998;12843.550475733304;11124.721881952935;11235.21353505255;11371.886281137247;11637.243579167412;11644.708882278012;9726.221902247875;9758.560864761032;9796;9959.701208963743;10020.398776073458;3618.5295911531593;3628.0385697790107;3653.6346365363515;3711.2763011212824;3779.036345731821;42392.36411453831;42598;43694.78152609216;44903.55096449059;49068.509314906754;7270.563766174047;7393.667284972082;7468.439867009996;7571.734989275349;7747.845043099106;12007.279563226235;12042.879571204176;12069.215500992408;12085.214461060003;12105.213161144497;6923.376896079377;6941.201761797357;7021.262767409451;7062.258462861429;7093.751718689924;4558.88602784933;4564.612007979293;4596.543367474116;4600.102979918951;4649.558291962258;2685.9597106043425;2728.399752054545;2731.098737416648;2733.931651708723;2742.1910536391415;428.3510481620348;429.44387018810716;433.21155496995164;433.8156283579466;435.4339358833504;655.8978473990848;659.7196191618543;666.6533602123683;675.6182756742425;708.6633848921824;8213.38399620019;8450.450720703258;8511.872321915176;8556.18716221958;8619.956900215459;531.3411369901372;602.8492876780805;669.2270427656065;676.0787432889223;707.0843257980927;4135.152293779768;4151.875443736692;4212.515560710496;4257.765822879709;4278.117588316066;57252;58760.41239587635;58958;59055.11417328744;59149.40850591439;44558.77720611441;44796;51648.48351516512;52284.47715522796;53105;45077.323840142424;46065;47993.76003120032;49275.26087108696;49340.50659493359;7475.850482990201;8613.612387442456;9004.279657627243;9093.54532273397;9201.263898887939;36681.266374672894;36738.448923266704;37261.254774903806;37303.81348093351;37415.62584374121;45790.54209457996;46196.307055393525;46614.533854662375;46681.76659116683;47155.76422117867;8013.8397232056195;8040.316573091352;8158.877616835871;8228.424010319459;8344.290735287568;12708;12742.68143296425;12776.61670149897;12925.482980681043;13331.866681333451;11395.202335836744;11460.197786155222;11649.534018639159;11924.761504769682;11961.102917281412;11220.887791121984;11291.604793832177;11519.538342909933;11569.826452603385;11874;11080.778384432428;11258.831117533407;11495.54017839277;11838.408079596158;11864.40677966081;10048.09567138961;10070.798584028133;10294.588216471257;10328.225383096447;10418.479076046318;8914.420562663407;9435.150836424755;9587.760305992406;9606.423614583147;9714 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,765 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: __startTimestamp1447717133304__endTimestamp 15:38:53 INFO - 2015-11-16 15:38:53,312 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5441.70 Median:5668.91 stddev:612.23 (10.8%) stddev-sans-first:587.35 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: Values: 3159.6 3221.1 3252.8 3262.3 3282.6 5160.1 5303.7 5411.1 5430.8 5447.6 5348.3 5359.4 5436.3 5503.0 5514.9 4908.0 4932.6 4949.8 4974.0 5000.5 5020.3 5079.5 5085.5 5135.6 5143.1 4760.5 4850.1 4866.5 4964.8 4978.6 4988.8 5001.0 5006.7 5009.3 5044.4 4788.0 4987.8 4996.3 5014.7 5044.2 5097.1 5124.7 5186.2 5212.2 5227.3 5838.2 5919.3 5928.1 5933.6 5935.5 5724.4 5866.3 5952.4 5967.9 5968.3 5382.7 5442.4 5464.2 5467.8 5510.0 5973.9 5978.9 6000.5 6049.3 6052.9 5611.7 5765.9 5803.1 5808.0 5851.5 5809.0 5889.7 5890.1 5891.0 5918.8 5767.3 5897.1 5922.0 5927.5 5935.9 5714.8 5744.1 5837.9 5912.6 5927.6 4543.6 4544.0 4545.1 4551.8 4584.4 4039.4 4039.6 4048.8 4051.4 4089.2 5373.4 5494.4 5498.0 5601.1 5624.3 5905.9 5967.8 5993.6 5994.3 5995.9 5646.4 5649.9 5661.3 5668.9 5669.9 4944.7 4985.3 5027.5 5079.8 5107.7 6045.6 6053.7 6053.9 6059.2 6059.5 5772.9 5873.9 5877.2 5885.8 5888.7 5955.2 6016.1 6068.6 6103.0 6103.9 5664.1 5669.4 5675.4 5688.8 5784.5 5763.5 5771.2 5772.1 5780.4 5781.5 5582.7 5686.3 5785.0 5787.5 5839.2 5801.3 5824.3 5835.9 5837.9 5840.4 5451.3 5555.3 5713.1 5717.8 5730.6 5707.7 5791.7 5799.5 5817.5 5837.0 5598.0 5627.7 5629.8 5643.2 5689.5 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,314 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50308.98 Median:18367.69 stddev:89879.30 (489.3%) stddev-sans-first:90053.82 15:38:53 INFO - 2015-11-16 15:38:53,316 DEBUG : BROWSER_OUTPUT: Values: 561.3 587.5 588.4 594.5 594.7 31727.8 32340.9 32480.4 40294.8 40570.0 43822.0 44285.1 44396.0 44397.8 44460.3 8638.7 8831.5 8852.6 8854.8 8855.2 7897.0 8050.7 8065.3 10209.1 10466.5 10109.1 10204.3 10216.3 10223.6 10224.4 10038.9 10069.6 10073.8 10086.6 10129.4 7856.8 8055.6 10329.9 10720.6 10726.9 39802.4 40195.8 40243.6 40265.8 40291.6 2910.6 2915.2 2950.4 3014.9 3355.9 30582.7 30789.2 31280.8 31525.7 32052.5 3490.8 3495.6 3521.1 3602.5 3608.7 273473.0 274386.0 274990.0 275578.0 275579.0 55811.4 57094.0 57145.0 58883.4 59180.4 60812.4 61198.1 61227.0 61249.4 61335.7 13281.6 13372.8 13475.5 13494.6 13505.5 9960.3 10006.1 10042.6 10115.5 10122.6 19455.5 19547.2 19557.3 19569.1 19582.6 8035.0 8058.5 8137.8 8177.7 8220.5 919.0 926.9 997.3 1006.3 1056.4 28105.9 28634.9 28706.7 28816.1 28861.4 1023.5 1026.9 1081.9 1088.2 1091.2 14456.5 15001.2 15099.2 15372.2 15376.8 379272.0 383290.0 383689.0 386267.0 387872.0 53132.0 53498.5 53683.2 53699.0 53746.7 1158.5 1368.5 1372.8 1394.2 1399.1 23190.9 30276.8 30689.4 30698.4 31340.4 50635.0 51330.2 51341.5 51396.2 51429.0 303229.0 306705.0 307178.0 418540.0 424591.0 32549.2 32807.3 32858.8 33224.8 33379.5 41354.2 42862.8 42995.1 43218.8 43758.6 35979.8 36113.8 36297.3 36307.8 37362.4 36210.0 36238.0 36360.0 36366.6 36837.0 34848.0 35921.6 35971.6 35974.8 36001.3 29697.6 32879.0 33054.8 33224.0 33379.3 25010.4 25577.4 26990.5 27364.2 27531.3 15:38:53 INFO - 2015-11-16 15:38:53,316 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,316 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23919.38 Median:2521.32 stddev:70807.41 (2808.3%) stddev-sans-first:70983.90 15:38:53 INFO - 2015-11-16 15:38:53,317 DEBUG : BROWSER_OUTPUT: Values: 334.5 335.1 337.9 344.2 353.2 14664.9 15127.5 17054.0 17119.6 17629.6 14628.6 16575.0 16683.7 16766.5 17687.3 5218.9 5321.1 5329.0 5329.9 5331.0 3866.3 4034.6 5287.9 5304.3 5651.1 5764.0 5788.5 5791.7 5795.6 5800.3 5647.4 5730.8 5796.0 5808.4 5811.4 5045.3 5047.5 5055.8 5055.9 5056.7 20275.2 20384.0 20646.5 20791.2 20799.3 2157.7 2160.7 2191.7 2352.2 2513.9 8853.2 9158.6 9249.4 13133.6 13641.1 1630.8 1647.9 1654.1 1673.0 1730.3 57795.7 58019.4 58311.0 60638.0 63245.4 6675.9 6753.9 6761.4 6837.1 6868.5 8117.0 8132.9 8134.8 8141.5 8142.3 5104.0 5122.5 5128.2 5152.3 5156.9 5138.5 5196.5 5202.3 5226.7 5236.8 3082.6 3137.8 3144.6 3149.5 3157.5 1073.7 1096.9 1125.6 1135.7 1161.4 474.4 480.3 498.5 512.1 515.1 11260.7 11300.1 11356.0 11356.6 11945.1 412.2 480.3 486.1 488.7 495.4 4630.4 5953.7 6018.7 6154.4 6226.1 405125.0 405638.0 406789.3 410158.0 512845.0 78341.6 79155.2 80624.0 81177.2 82188.0 512.9 520.7 522.3 523.6 523.9 10380.7 10822.3 10882.1 10906.6 10994.4 31631.7 32588.5 32911.7 33395.0 33520.5 38931.4 39152.6 39735.2 40020.6 40328.8 6515.3 6580.3 6666.6 6671.1 6676.2 11897.1 12030.2 12162.8 12209.9 12239.3 10365.8 10373.8 10511.8 10533.2 10695.2 10114.7 10281.2 10410.7 10532.5 10712.6 8384.3 8464.7 10650.7 10698.2 10908.9 5861.4 6082.0 6710.2 6725.7 6737.5 9912.5 10461.3 10566.7 10876.0 10917.2 15:38:53 INFO - 2015-11-16 15:38:53,317 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,317 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5373.78 Median:6295.07 stddev:2820.92 (44.8%) stddev-sans-first:2810.94 15:38:53 INFO - 2015-11-16 15:38:53,317 DEBUG : BROWSER_OUTPUT: Values: 1147.4 1468.3 1474.2 1689.7 1762.0 6521.6 7237.7 7372.2 7385.0 7388.4 7514.9 7614.6 7617.4 7625.8 7638.1 1958.2 2003.4 2242.2 2254.5 2275.6 2286.9 2289.7 2293.3 2294.1 2294.2 2221.3 2270.0 2270.9 2272.4 2275.8 1994.1 2038.7 2225.2 2263.4 2267.7 2245.5 2246.9 2270.5 2272.8 2314.8 7477.6 7488.2 7572.8 7579.3 7595.2 4533.3 4626.2 4629.7 4631.2 4641.6 2986.2 3027.6 3050.6 3078.3 3111.8 976.9 985.8 1015.1 1032.0 1039.8 10684.3 10705.5 10710.8 10732.8 10736.9 4095.4 4155.7 4180.1 4291.9 4297.4 9123.2 9127.5 9127.6 9141.6 9148.0 4638.2 4638.3 4658.4 4659.7 4663.0 4236.9 4259.0 4263.9 4270.2 4270.6 3709.2 3748.9 3755.6 3770.2 3790.1 1203.9 1214.0 1219.5 1221.8 1225.5 966.1 1263.5 1274.6 1298.9 1306.5 6482.3 6999.2 7371.8 7394.8 7402.0 639.1 648.5 649.4 656.6 657.1 5685.8 5742.2 5763.1 5773.6 5786.5 9359.3 9538.5 9547.1 9683.9 9701.1 9268.0 9437.3 9500.1 9552.2 9571.9 7088.4 7157.4 7203.8 7213.6 7219.1 6383.6 6524.9 6531.3 6555.5 6558.6 8242.5 8358.0 8418.4 8434.7 8438.2 8449.7 8522.9 8685.7 8694.3 8710.4 6654.9 6698.5 6711.4 6714.8 6715.0 7407.0 7438.8 7496.1 7498.0 7499.3 7008.9 7056.5 7066.8 7088.0 7175.4 6881.6 6911.6 6956.4 7009.1 7093.1 6075.1 6226.0 7067.7 7115.4 7121.7 6068.5 6216.2 6273.6 6287.5 6288.9 6088.5 6274.0 6301.2 6307.3 6320.8 15:38:53 INFO - 2015-11-16 15:38:53,317 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,318 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5310.54 Median:6062.56 stddev:1619.67 (26.7%) stddev-sans-first:1580.19 15:38:53 INFO - 2015-11-16 15:38:53,318 DEBUG : BROWSER_OUTPUT: Values: 313.5 319.7 320.9 322.0 324.5 5863.2 5916.7 5991.7 5997.7 6009.1 5763.8 5892.2 5928.7 5936.9 5937.4 4378.6 4495.6 4525.5 4533.4 4540.4 4455.2 4511.0 4519.4 4531.2 4532.0 4468.8 4469.4 4476.2 4477.6 4488.9 4472.6 4484.4 4491.6 4494.5 4540.3 3889.9 3971.4 3972.1 3978.8 3980.7 5591.0 5612.9 5622.4 5634.9 5641.5 5295.3 5298.6 5299.9 5300.4 5305.1 6054.0 6169.4 6217.6 6328.1 6344.9 4340.5 4357.2 4365.6 4371.3 4378.3 6564.1 6568.2 6569.9 6578.3 6584.1 4381.5 4449.1 4460.3 4488.1 4495.6 4515.5 4523.5 4526.3 4537.8 4539.6 5260.7 5262.8 5267.3 5268.1 5268.6 6379.3 6383.9 6386.5 6391.2 6397.3 1580.2 1597.9 1617.6 1620.6 1620.6 1054.7 1081.9 1084.0 1087.1 1088.5 6192.5 6194.9 6198.2 6206.3 6209.4 6541.5 6542.4 6548.9 6553.2 6554.2 6071.1 6161.0 6169.5 6180.9 6186.1 3525.2 3548.8 3552.5 3556.6 3557.1 6749.6 6814.8 6815.1 6815.5 6816.5 6711.6 6733.1 6739.2 6740.4 6748.7 6706.3 6869.0 6874.4 6886.5 6887.2 6368.6 6446.8 6520.8 6649.0 6657.6 6546.1 6559.4 6574.1 6576.0 6583.8 6764.5 6867.3 6870.0 6887.6 6891.1 4434.4 4461.9 4474.0 4474.1 4474.8 6606.5 6612.3 6612.9 6616.2 6619.7 6345.8 6399.2 6403.0 6403.8 6408.2 6284.2 6416.6 6418.1 6423.0 6430.6 6278.3 6293.1 6295.8 6306.4 6306.5 6340.5 6445.7 6451.8 6455.2 6456.1 6263.4 6300.9 6306.8 6311.7 6317.8 15:38:53 INFO - 2015-11-16 15:38:53,318 DEBUG : BROWSER_OUTPUT: 15:38:53 INFO - 2015-11-16 15:38:53,318 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13461.89 Median:25632.05 stddev:16003.89 (62.4%) stddev-sans-first:16020.04 15:38:53 INFO - 2015-11-16 15:38:53,319 DEBUG : BROWSER_OUTPUT: Values: 689.3 799.2 855.4 884.1 885.8 13561.3 13788.1 13804.9 13811.8 13846.1 11730.1 12359.1 12379.2 12436.0 12529.0 825.1 840.1 840.3 840.3 841.2 829.4 829.8 837.1 837.7 838.2 875.2 876.8 877.7 877.8 877.9 873.0 873.6 873.9 874.9 879.0 640.9 640.9 641.1 643.5 645.6 12665.2 12821.9 12824.3 12836.7 12843.6 11124.7 11235.2 11371.9 11637.2 11644.7 9726.2 9758.6 9796.0 9959.7 10020.4 3618.5 3628.0 3653.6 3711.3 3779.0 42392.4 42598.0 43694.8 44903.6 49068.5 7270.6 7393.7 7468.4 7571.7 7747.8 12007.3 12042.9 12069.2 12085.2 12105.2 6923.4 6941.2 7021.3 7062.3 7093.8 4558.9 4564.6 4596.5 4600.1 4649.6 2686.0 2728.4 2731.1 2733.9 2742.2 428.4 429.4 433.2 433.8 435.4 655.9 659.7 666.7 675.6 708.7 8213.4 8450.5 8511.9 8556.2 8620.0 531.3 602.8 669.2 676.1 707.1 4135.2 4151.9 4212.5 4257.8 4278.1 57252.0 58760.4 58958.0 59055.1 59149.4 44558.8 44796.0 51648.5 52284.5 53105.0 45077.3 46065.0 47993.8 49275.3 49340.5 7475.9 8613.6 9004.3 9093.5 9201.3 36681.3 36738.4 37261.3 37303.8 37415.6 45790.5 46196.3 46614.5 46681.8 47155.8 8013.8 8040.3 8158.9 8228.4 8344.3 12708.0 12742.7 12776.6 12925.5 13331.9 11395.2 11460.2 11649.5 11924.8 11961.1 11220.9 11291.6 11519.5 11569.8 11874.0 11080.8 11258.8 11495.5 11838.4 11864.4 10048.1 10070.8 10294.6 10328.2 10418.5 8914.4 9435.2 9587.8 9606.4 9714.0 15:38:53 INFO - 2015-11-16 15:38:53,319 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:38:53 INFO - 2015-11-16 15:38:53,319 DEBUG : BROWSER_OUTPUT: 15:38:54 INFO - 2015-11-16 15:38:54,037 INFO : Browser exited with error code: 0 15:38:54 INFO - 2015-11-16 15:38:54,056 INFO : Completed test dromaeo_css (00:18:32) 15:38:54 INFO - 2015-11-16 15:38:54,056 INFO : Starting test kraken 15:38:54 INFO - 2015-11-16 15:38:54,056 DEBUG : operating with platform_type : linux_ 15:38:54 INFO - 2015-11-16 15:38:54,056 INFO : Initialising browser for kraken test... 15:38:54 INFO - 2015-11-16 15:38:54,062 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpigsRKc/profile http://localhost:32983/getInfo.html 15:38:57 INFO - 2015-11-16 15:38:57,756 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:38:57 INFO - 2015-11-16 15:38:57,756 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:38:57 INFO - 2015-11-16 15:38:57,756 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:38:57 INFO - 2015-11-16 15:38:57,756 DEBUG : BROWSER_OUTPUT: __metrics 15:38:57 INFO - 2015-11-16 15:38:57,925 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:59 INFO - 2015-11-16 15:38:59,067 INFO : Browser initialized. 15:38:59 INFO - 2015-11-16 15:38:59,067 INFO : Running cycle 1/1 for kraken test... 15:38:59 INFO - 2015-11-16 15:38:59,068 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpigsRKc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:39:10 INFO - 2015-11-16 15:39:10,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 141787136 15:39:10 INFO - 2015-11-16 15:39:10,807 DEBUG : BROWSER_OUTPUT: 15:39:13 INFO - 2015-11-16 15:39:13,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32983/tests/kraken/driver.html?testName=audio-beat-detection) 15:39:13 INFO - 2015-11-16 15:39:13,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 180068352 15:39:13 INFO - 2015-11-16 15:39:13,875 DEBUG : BROWSER_OUTPUT: 15:39:16 INFO - 2015-11-16 15:39:16,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32983/tests/kraken/driver.html?testName=audio-dft) 15:39:17 INFO - 2015-11-16 15:39:17,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 170151936 15:39:17 INFO - 2015-11-16 15:39:17,042 DEBUG : BROWSER_OUTPUT: 15:39:19 INFO - 2015-11-16 15:39:19,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32983/tests/kraken/driver.html?testName=audio-fft) 15:39:20 INFO - 2015-11-16 15:39:20,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 151965696 15:39:20 INFO - 2015-11-16 15:39:20,474 DEBUG : BROWSER_OUTPUT: 15:39:22 INFO - 2015-11-16 15:39:22,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32983/tests/kraken/driver.html?testName=audio-oscillator) 15:39:23 INFO - 2015-11-16 15:39:23,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 152715264 15:39:23 INFO - 2015-11-16 15:39:23,036 DEBUG : BROWSER_OUTPUT: 15:39:25 INFO - 2015-11-16 15:39:25,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:25 INFO - 2015-11-16 15:39:25,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 154300416 15:39:25 INFO - 2015-11-16 15:39:25,754 DEBUG : BROWSER_OUTPUT: 15:39:28 INFO - 2015-11-16 15:39:28,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32983/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:29 INFO - 2015-11-16 15:39:29,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 154914816 15:39:29 INFO - 2015-11-16 15:39:29,209 DEBUG : BROWSER_OUTPUT: 15:39:32 INFO - 2015-11-16 15:39:32,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32983/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:33 INFO - 2015-11-16 15:39:33,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 156372992 15:39:33 INFO - 2015-11-16 15:39:33,158 DEBUG : BROWSER_OUTPUT: 15:39:35 INFO - 2015-11-16 15:39:35,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32983/tests/kraken/driver.html?testName=json-parse-financial) 15:39:36 INFO - 2015-11-16 15:39:36,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 156299264 15:39:36 INFO - 2015-11-16 15:39:36,515 DEBUG : BROWSER_OUTPUT: 15:39:38 INFO - 2015-11-16 15:39:38,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:38 INFO - 2015-11-16 15:39:38,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 163725312 15:39:38 INFO - 2015-11-16 15:39:38,622 DEBUG : BROWSER_OUTPUT: 15:39:40 INFO - 2015-11-16 15:39:40,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:41 INFO - 2015-11-16 15:39:41,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 163999744 15:39:41 INFO - 2015-11-16 15:39:41,038 DEBUG : BROWSER_OUTPUT: 15:39:43 INFO - 2015-11-16 15:39:43,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:43 INFO - 2015-11-16 15:39:43,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 168488960 15:39:43 INFO - 2015-11-16 15:39:43,671 DEBUG : BROWSER_OUTPUT: 15:39:46 INFO - 2015-11-16 15:39:46,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:46 INFO - 2015-11-16 15:39:46,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 176852992 15:39:46 INFO - 2015-11-16 15:39:46,638 DEBUG : BROWSER_OUTPUT: 15:39:49 INFO - 2015-11-16 15:39:49,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:49 INFO - 2015-11-16 15:39:49,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 175808512 15:39:49 INFO - 2015-11-16 15:39:49,732 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32983/tests/kraken/driver.html?testName=ai-astar) 15:39:51 INFO - 2015-11-16 15:39:51,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 235446272 15:39:51 INFO - 2015-11-16 15:39:51,631 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;110;112;112;102;112;112;109 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;123;152;160;124;150;151;126;170;125 15:39:51 INFO - 2015-11-16 15:39:51,635 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;162;162;161;162;161;163;161;162 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;93;73;71;73;122;92;73 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;134;89;90;90;131;90;90;135 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;108;109;109 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;144;146;145;147;145;146;145;146 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;56;58;57;58;64;55;56 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;69;70;69;69;69;69 15:39:51 INFO - 2015-11-16 15:39:51,636 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;84;84;84;85;85;85;85 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;115;119;114;121;117;121;124;116;123 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;139;148;148;153;140;149;149;150;144 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;65;66;67;66;66;66;65;65 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,933 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: __startTimestamp1447717191632__endTimestamp 15:39:51 INFO - 2015-11-16 15:39:51,637 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:3.41 (3.1%) stddev-sans-first:3.61 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 110.0 112.0 112.0 102.0 112.0 112.0 109.0 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.50 stddev:17.21 (11.4%) stddev-sans-first:17.97 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: Values: 152.0 123.0 152.0 160.0 124.0 150.0 151.0 126.0 170.0 125.0 15:39:51 INFO - 2015-11-16 15:39:51,639 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 162.0 162.0 161.0 162.0 161.0 163.0 161.0 162.0 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:73.00 stddev:16.60 (22.7%) stddev-sans-first:17.26 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 93.0 73.0 71.0 73.0 122.0 92.0 73.0 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:89.50 stddev:21.17 (23.6%) stddev-sans-first:21.86 15:39:51 INFO - 2015-11-16 15:39:51,640 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 134.0 89.0 90.0 90.0 131.0 90.0 90.0 135.0 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 144.0 146.0 145.0 147.0 145.0 146.0 145.0 146.0 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,641 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:39:51 INFO - 2015-11-16 15:39:51,642 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:39:51 INFO - 2015-11-16 15:39:51,642 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,642 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:2.45 (4.2%) stddev-sans-first:2.60 15:39:51 INFO - 2015-11-16 15:39:51,642 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 56.0 58.0 57.0 58.0 64.0 55.0 56.0 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 84.0 84.0 84.0 85.0 85.0 85.0 85.0 15:39:51 INFO - 2015-11-16 15:39:51,643 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.00 stddev:3.86 (3.2%) stddev-sans-first:3.59 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: Values: 113.0 115.0 119.0 114.0 121.0 117.0 121.0 124.0 116.0 123.0 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.50 stddev:4.90 (3.3%) stddev-sans-first:4.69 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: Values: 140.0 139.0 148.0 148.0 153.0 140.0 149.0 149.0 150.0 144.0 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 15:39:51 INFO - 2015-11-16 15:39:51,644 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 65.0 66.0 67.0 66.0 66.0 66.0 65.0 65.0 15:39:51 INFO - 2015-11-16 15:39:51,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:39:51 INFO - 2015-11-16 15:39:51,646 DEBUG : BROWSER_OUTPUT: 15:39:52 INFO - 2015-11-16 15:39:52,454 INFO : Browser exited with error code: 0 15:39:52 INFO - 2015-11-16 15:39:52,504 INFO : Completed test kraken (00:00:58) 15:39:52 INFO - 2015-11-16 15:39:52,504 INFO : Starting test v8_7 15:39:52 INFO - 2015-11-16 15:39:52,504 DEBUG : operating with platform_type : linux_ 15:39:52 INFO - 2015-11-16 15:39:52,504 INFO : Initialising browser for v8_7 test... 15:39:52 INFO - 2015-11-16 15:39:52,510 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZr0Cmi/profile http://localhost:32983/getInfo.html 15:39:56 INFO - 2015-11-16 15:39:56,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:39:56 INFO - 2015-11-16 15:39:56,128 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:39:56 INFO - 2015-11-16 15:39:56,128 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:39:56 INFO - 2015-11-16 15:39:56,128 DEBUG : BROWSER_OUTPUT: __metrics 15:39:56 INFO - 2015-11-16 15:39:56,265 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:39:57 INFO - 2015-11-16 15:39:57,431 INFO : Browser initialized. 15:39:57 INFO - 2015-11-16 15:39:57,431 INFO : Running cycle 1/1 for v8_7 test... 15:39:57 INFO - 2015-11-16 15:39:57,431 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZr0Cmi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:40:09 INFO - 2015-11-16 15:40:09,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 141508608 15:40:09 INFO - 2015-11-16 15:40:09,186 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32983/tests/v8_7/run.html (next: http://localhost:32983/tests/v8_7/run.html) 15:40:30 INFO - 2015-11-16 15:40:30,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 166187008 15:40:30 INFO - 2015-11-16 15:40:30,847 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,848 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:40:30 INFO - 2015-11-16 15:40:30,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:40:30 INFO - 2015-11-16 15:40:30,848 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |0;Richards;163.42539630658604 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.1747572815534 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.09090909090907 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1106.1946902654868 15:40:30 INFO - 2015-11-16 15:40:30,849 DEBUG : BROWSER_OUTPUT: |5;Earley;809.0614886731391 15:40:30 INFO - 2015-11-16 15:40:30,850 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 15:40:30 INFO - 2015-11-16 15:40:30,850 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 15:40:30 INFO - 2015-11-16 15:40:30,850 DEBUG : BROWSER_OUTPUT: |8;Splay;568.8282138794084 15:40:30 INFO - 2015-11-16 15:40:30,850 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 15:40:30 INFO - 2015-11-16 15:40:30,850 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:40:30 INFO - 2015-11-16 15:40:30,851 DEBUG : BROWSER_OUTPUT: __startTimestamp1447717230847__endTimestamp 15:40:30 INFO - 2015-11-16 15:40:30,851 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,851 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:40:30 INFO - 2015-11-16 15:40:30,851 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:40:30 INFO - 2015-11-16 15:40:30,851 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.43 Median:163.43 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: Values: 163.4 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.17 Median:194.17 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: Values: 194.2 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,852 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.09 Median:284.09 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,853 DEBUG : BROWSER_OUTPUT: Values: 284.1 15:40:30 INFO - 2015-11-16 15:40:30,853 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: Values: 5040.2 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: Values: 1106.2 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,854 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.06 Median:809.06 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: Values: 809.1 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: Values: 12011.9 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: Values: 26025.6 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:568.83 Median:568.83 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: Values: 568.8 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: Values: 4835.7 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:40:30 INFO - 2015-11-16 15:40:30,855 DEBUG : BROWSER_OUTPUT: 15:40:31 INFO - 2015-11-16 15:40:31,713 INFO : Browser exited with error code: 0 15:40:31 INFO - 2015-11-16 15:40:31,730 INFO : Completed test v8_7 (00:00:39) 15:40:31 INFO - 2015-11-16 15:40:31,845 INFO : Completed test suite (00:20:10) 15:40:31 INFO - 2015-11-16 15:40:31,845 DEBUG : Working with test: dromaeo_css 15:40:31 INFO - 2015-11-16 15:40:31,845 DEBUG : Generating results file: dromaeo_css 15:40:31 INFO - 2015-11-16 15:40:31,846 DEBUG : Working with test: kraken 15:40:31 INFO - 2015-11-16 15:40:31,846 DEBUG : Generating results file: kraken 15:40:31 INFO - 2015-11-16 15:40:31,846 INFO : javascript benchmark 15:40:31 INFO - 2015-11-16 15:40:31,847 DEBUG : Working with test: v8_7 15:40:31 INFO - 2015-11-16 15:40:31,847 DEBUG : Generating results file: v8_7 15:40:31 INFO - 2015-11-16 15:40:31,847 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:31 INFO - 2015-11-16 15:40:31,901 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 15:40:31 INFO - 2015-11-16 15:40:31,901 DEBUG : process_Request line: dromaeo_css 6699.33 graph.html#tests=[[72,63,35]] 15:40:31 INFO - 2015-11-16 15:40:31,901 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:32 INFO - 2015-11-16 15:40:32,050 DEBUG : process_Request line: kraken 1489.50 graph.html#tests=[[232,63,35]] 15:40:32 INFO - 2015-11-16 15:40:32,051 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:40:32 INFO - 2015-11-16 15:40:32,081 DEBUG : process_Request line: v8_7 21137.85 graph.html#tests=[[230,63,35]] 15:40:32 INFO - 2015-11-16 15:40:32,082 INFO : javascript benchmark 15:40:32 INFO - 2015-11-16 15:40:32,086 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [334.5466892360851, 335.11696679250184, 337.87667501362006, 344.19115079563045, 353.18414462591414, 14664.926675366609, 15127.470538531154, 17054.0, 17119.57201069974, 17629.559261018465, 14628.561143165696, 16575.0, 16683.66632667349, 16766.497005089837, 17687.29250829965, 5218.895622087565, 5321.095413779667, 5328.973355133238, 5329.907368989348, 5331.0, 3866.3427217373114, 4034.5763694812063, 5287.894242115155, 5304.257403963448, 5651.124075768263, 5763.962486752383, 5788.536917046647, 5791.681457519835, 5795.623284486495, 5800.303963524383, 5647.3505546862225, 5730.770769169249, 5796.043652797283, 5808.361080281165, 5811.4479124483105, 5045.268436076748, 5047.47001564834, 5055.823046193365, 5055.898882022376, 5056.696598204119, 20275.175234228842, 20384.0, 20646.483837904023, 20791.16835326585, 20799.272025479037, 2157.6871353653632, 2160.7299087614047, 2191.6822060801096, 2352.2002519143402, 2513.949721005588, 8853.24747396472, 9158.587863546156, 9249.35254532183, 13133.60599182026, 13641.113327633771, 1630.8206097329285, 1647.9176041198011, 1654.0654530190404, 1673.0380031481945, 1730.3338214787398, 57795.71102144462, 58019.41980580182, 58311.0, 60638.0, 63245.36754632441, 6675.86648267032, 6753.864922701617, 6761.425278851254, 6837.145356830396, 6868.450523958171, 8116.959415203004, 8132.918670813335, 8134.796630084295, 8141.470804397695, 8142.348612111017, 5103.979204159183, 5122.487751224922, 5128.230765385222, 5152.3044389007755, 5156.871078222999, 5138.486151384906, 5196.45437229093, 5202.3497062867145, 5226.686398816083, 5236.764345604381, 3082.583851180062, 3137.796043257181, 3144.591203143577, 3149.5433162191352, 3157.542156387357, 1073.726199819041, 1096.8793432722555, 1125.58915995661, 1135.7160709822545, 1161.3960740415105, 474.3927772451268, 480.31555034077, 498.4541926590378, 512.0501469773517, 515.1294312611749, 11260.718482038015, 11300.095992320594, 11356.0, 11356.602518911799, 11945.065474289386, 412.1962173761118, 480.3011618095662, 486.12497504491773, 488.6994498383469, 495.37087898368867, 4630.4443466784205, 5953.702314884238, 6018.699065046818, 6154.446099851035, 6226.066090086523, 405125.0, 405638.0, 406789.2531821497, 410158.0, 512845.0, 78341.60829195818, 79155.20844791594, 80624.0, 81177.18822811815, 82188.0, 512.8794733237686, 520.7344254430268, 522.3027258609723, 523.5602094240855, 523.9345081864767, 10380.740481488023, 10822.296550724177, 10882.075023623082, 10906.61826836057, 10994.395308257803, 31631.683683162875, 32588.511172332906, 32911.67088329086, 33394.99815005554, 33520.49719254165, 38931.416028760155, 39152.608473916036, 39735.20529589334, 40020.599794002854, 40328.79835600803, 6515.250746164252, 6580.309067547839, 6666.600003999775, 6671.066050752802, 6676.232233293039, 11897.107716921439, 12030.15788894769, 12162.817557736818, 12209.938950305546, 12239.326837023693, 10365.792684146125, 10373.792524149323, 10511.789764204826, 10533.157347412342, 10695.197860160675, 10114.747131321776, 10281.177505799667, 10410.68767936963, 10532.473376331305, 10712.571497140027, 8384.32925365957, 8464.703735369232, 10650.680479585624, 10698.197635177237, 10908.945455272673, 5861.413858614104, 6081.969590152198, 6710.16122984627, 6725.663716814238, 6737.461003119641, 9912.454814984956, 10461.267711260443, 10566.735831603964, 10876.0, 10917.181211409017], "dojo.html": [3159.5576619273297, 3221.1463962050047, 3252.7560432967534, 3262.347530493902, 3282.5568548245988, 5160.122779127548, 5303.734813259341, 5411.107167317393, 5430.837074887755, 5447.645903016301, 5348.304720386354, 5359.38367087785, 5436.293281873361, 5502.972485137579, 5514.91727624086, 4908.0, 4932.630052746041, 4949.826756063539, 4974.0, 5000.524950129732, 5020.347354843865, 5079.492050794928, 5085.5423011928915, 5135.614828887829, 5143.09995750744, 4760.500147484516, 4850.054239423313, 4866.489018653044, 4964.776585053682, 4978.6017118630425, 4988.7505624718615, 5001.049800537922, 5006.674566153189, 5009.273655319958, 5044.419891712427, 4788.0, 4987.775550100254, 4996.2755400467095, 5014.674046187022, 5044.192929131322, 5097.133487307166, 5124.743762811881, 5186.222066689989, 5212.1921102228835, 5227.294315267428, 5838.1534677471955, 5919.348871624118, 5928.110783382484, 5933.614315069507, 5935.49548288396, 5724.398938111522, 5866.325372582122, 5952.404759524056, 5967.910481342783, 5968.253968253968, 5382.650127741724, 5442.374126975409, 5464.207689884945, 5467.808626698126, 5509.972450137724, 5973.910391344133, 5978.910316345258, 6000.549958753111, 6049.274087109575, 6052.878942421215, 5611.691356975405, 5765.85585360361, 5803.129530570363, 5808.0, 5851.531877449794, 5809.0, 5889.734961926723, 5890.057590785454, 5890.970545147333, 5918.7928422505, 5767.307923049177, 5897.085951677497, 5921.970390148022, 5927.4665280125, 5935.940640593625, 5714.828555143269, 5744.080947048452, 5837.9124313135335, 5912.645241285537, 5927.614705044159, 4543.636509079266, 4544.02303504748, 4545.0909818036525, 4551.8179272829375, 4584.426946631671, 4039.4142849287277, 4039.5758445362812, 4048.7570745755347, 4051.4125451809323, 4089.2434899543678, 5373.435789242151, 5494.395616482184, 5498.037843377393, 5601.131824567198, 5624.325080990226, 5905.911411328833, 5967.8209653710455, 5993.550483713651, 5994.340622531605, 5995.940040599626, 5646.407127251579, 5649.887002260014, 5661.34894487131, 5668.914966275509, 5669.914951275734, 4944.678595891256, 4985.252212168204, 5027.472115427828, 5079.822206222764, 5107.719075450812, 6045.607035542764, 6053.727582258809, 6053.939460605426, 6059.242594675666, 6059.515238780887, 5772.884542309214, 5873.911891321719, 5877.23595932526, 5885.793997210077, 5888.735006924613, 5955.196048533566, 6016.067509536029, 6068.605540639845, 6103.0, 6103.938960610515, 5664.0937450007805, 5669.4047125051275, 5675.432456754292, 5688.800891968761, 5784.4504772046585, 5763.51010164124, 5771.249737534094, 5772.134179873053, 5780.364159942487, 5781.4507621775865, 5582.748776304995, 5686.2607860977805, 5785.0, 5787.508061814793, 5839.15332276809, 5801.274840644919, 5824.271966004249, 5835.883282334415, 5837.854053648693, 5840.415958404125, 5451.3458384994055, 5555.2778138841695, 5713.143028545585, 5717.799877004285, 5730.627509211888, 5707.68607726579, 5791.652500849962, 5799.4780469757925, 5817.5345972321265, 5837.0368889132815, 5598.048331783688, 5627.690477023803, 5629.831105066854, 5643.181738647955, 5689.487946084872], "mootools.html": [1147.414818442594, 1468.2511918921355, 1474.1670955909904, 1689.7465380192973, 1762.0396883698384, 6521.576097553661, 7237.697214501388, 7372.225916278794, 7384.963075184623, 7388.408927285817, 7514.924850751491, 7614.619269036553, 7617.352525035379, 7625.809354766134, 7638.083429988395, 1958.2167133146713, 2003.388966365258, 2242.1703969531295, 2254.4589298568308, 2275.567642147995, 2286.874221917794, 2289.69089172962, 2293.289080385086, 2294.1167650454613, 2294.1511640692966, 2221.2669818959703, 2269.954600907981, 2270.909163633453, 2272.4432514034, 2275.8179345652306, 1994.0627904884682, 2038.6636205026152, 2225.1766846266905, 2263.3888850010403, 2267.716535433071, 2245.5059886825034, 2246.9325920222254, 2270.545890821842, 2272.818174546049, 2314.7916687498036, 7477.551346919202, 7488.213737557532, 7572.848543029108, 7579.279968402993, 7595.202503737083, 4533.320001999694, 4626.21354369758, 4629.65277604181, 4631.16639004979, 4641.605463535603, 2986.1788008297676, 3027.63668359796, 3050.5881705969855, 3078.291992841637, 3111.844407779602, 976.9218462522981, 985.7781999050156, 1015.1472762879217, 1031.9742006449824, 1039.7920415916847, 10684.252102352839, 10705.518251678694, 10710.785784284271, 10732.785344293148, 10736.892631073668, 4095.447114639545, 4155.709100362946, 4180.143070670505, 4291.871243862689, 4297.39836422901, 9123.224525915371, 9127.543622818832, 9127.634894604274, 9141.634334626673, 9148.0, 4638.1883170445035, 4638.304254361873, 4658.440987081504, 4659.65052621048, 4663.020765639254, 4236.915261694749, 4259.041715614024, 4263.893402664959, 4270.188664153801, 4270.615644592001, 3709.1839795245005, 3748.9250214995545, 3755.6432138946757, 3770.1894092770185, 3790.0714324990554, 1203.8735932727113, 1213.9878601214052, 1219.469530754125, 1221.82283568882, 1225.546547777328, 966.1111777165025, 1263.5451237554473, 1274.5539061328461, 1298.9220646761225, 1306.510058727977, 6482.319356467598, 6999.23008469068, 7371.8157046074275, 7394.778156655201, 7402.0, 639.0573903492311, 648.4876947211744, 649.399305642279, 656.5633853487473, 657.1293036726356, 5685.800996965087, 5742.16738572913, 5763.077907534858, 5773.566982476331, 5786.508146807484, 9359.298052645943, 9538.52307384628, 9547.093026162504, 9683.854742178873, 9701.126898579161, 9268.0, 9437.292203084797, 9500.144986951207, 9552.235821134293, 9571.856422153534, 7088.432925365958, 7157.391621712213, 7203.819904502325, 7213.639318034077, 7219.133703955454, 6383.648899310582, 6524.902126468011, 6531.281559028408, 6555.541112122106, 6558.606483610999, 8242.464239824392, 8357.95821020891, 8418.400503904239, 8434.662613495637, 8438.240558349778, 8449.66201351939, 8522.914770852212, 8685.696000639948, 8694.34792390586, 8710.433821801562, 6654.933450665431, 6698.531102822755, 6711.362420570038, 6714.798556043326, 6714.966425167843, 7407.0, 7438.814029649302, 7496.137944136276, 7497.962510187414, 7499.287567681062, 7008.859822803617, 7056.470764692566, 7066.8233294166, 7087.964560177166, 7175.354218120394, 6881.552699074544, 6911.550749201286, 6956.40870526011, 7009.0537777399395, 7093.113360829896, 6075.058365953284, 6226.0, 7067.71729130829, 7115.359617634438, 7121.67952442131, 6068.4841788448475, 6216.222972128484, 6273.62358258506, 6287.46556542699, 6288.905666415099, 6088.452039316483, 6274.027525733519, 6301.243850737757, 6307.337729538516, 6320.778772742932], "ext.html": [561.2757827128964, 587.5299760191842, 588.3733823477993, 594.5124997502047, 594.7056207177446, 31727.841360793194, 32340.897841640308, 32480.350392992157, 40294.798526007406, 40570.0, 43822.0, 44285.114297714026, 44396.0, 44397.77801110998, 44460.3330950036, 8638.740837774876, 8831.47011179328, 8852.645894164258, 8854.778630534223, 8855.203031727144, 7896.960515197416, 8050.677972881078, 8065.2741253287195, 10209.081182693557, 10466.529006194702, 10109.14072303855, 10204.336718113298, 10216.335938163995, 10223.591056357736, 10224.386536807779, 10038.899611003906, 10069.647562335284, 10073.798524029478, 10086.596536138546, 10129.442880641562, 7856.842863142705, 8055.637496312622, 10329.896701033043, 10720.571177152904, 10726.946365268202, 39802.40296395557, 40195.799021005, 40243.597564024276, 40265.79867100646, 40291.56063931361, 2910.57796619489, 2915.227464721829, 2950.439416510856, 3014.9246268843235, 3355.882544110969, 30582.69417305843, 30789.230269243224, 31280.843595782102, 31525.684743152506, 32052.519212211835, 3490.8080055596934, 3495.615482296945, 3521.102118959649, 3602.5136606558303, 3608.675219230282, 273473.0, 274386.0, 274990.0, 275578.0, 275579.0, 55811.44188558144, 57094.0, 57145.0, 58883.41116588865, 59180.40819591749, 60812.39187608156, 61198.082028769604, 61227.0, 61249.38750612526, 61335.693321533996, 13281.601551953458, 13372.799408008888, 13475.528356507672, 13494.595162145151, 13505.52730654442, 9960.252981026451, 10006.09945104944, 10042.598296068076, 10115.494225288707, 10122.645707400354, 19455.513612159808, 19547.21811127539, 19557.31549395764, 19569.119389627216, 19582.608347833248, 8034.959825200836, 8058.476199047043, 8137.837243255101, 8177.713780017671, 8220.547869867214, 918.9816203675889, 926.8887733472027, 997.2719914462338, 1006.3244697578596, 1056.3609016544879, 28105.859470702515, 28634.85682571574, 28706.71293287082, 28816.135515934555, 28861.42277154445, 1023.4729114506035, 1026.8870424253475, 1081.8864019277862, 1088.2219213262556, 1091.170710260192, 14456.494022709154, 15001.17493537844, 15099.245037748069, 15372.231388430533, 15376.769348459782, 379272.0, 383290.0, 383689.0, 386267.0, 387872.0, 53132.0, 53498.46501534935, 53683.19475207875, 53699.0, 53746.73126634342, 1158.5423757615526, 1368.5141774670049, 1372.8009438631543, 1394.2331717555303, 1399.069618703571, 23190.884045579664, 30276.84861575678, 30689.386212276077, 30698.386032279675, 31340.373192536477, 50635.0, 51330.23004654858, 51341.48658513367, 51396.22905656343, 51429.0, 303229.0, 306705.0, 307178.0, 418540.0, 424591.0, 32549.18627034343, 32807.34385312328, 32858.835705821315, 33224.83387583047, 33379.499307510894, 41354.1729165409, 42862.78568607137, 42995.140097197254, 43218.783906080265, 43758.56241437545, 35979.82010089933, 36113.81943090268, 36297.27405451929, 36307.818460907525, 37362.43956340711, 36210.0, 36238.0, 36360.0, 36366.63633363633, 36837.0, 34848.0, 35921.64078359288, 35971.64028359787, 35974.820125899205, 36001.27997440089, 29697.554536681535, 32879.0, 33054.834725826215, 33224.0, 33379.33241335208, 25010.373495843363, 25577.360565986, 26990.460190796468, 27364.179074627795, 27531.31171720723], "prototype.html": [313.5359667691816, 319.6771261026363, 320.858822118268, 322.03871443740445, 324.5035096302658, 5863.208466856973, 5916.704164791765, 5991.670458124801, 5997.730102145409, 6009.1286763419275, 5763.82708518744, 5892.2340095787595, 5928.6739229342365, 5936.940630593704, 5937.435943585363, 4378.62781663559, 4495.595396414322, 4525.479569849468, 4533.410656614652, 4540.364348991144, 4455.220336441126, 4511.0, 4519.367288579601, 4531.210171982065, 4531.977340113295, 4468.798904049309, 4469.374287599739, 4476.194285028693, 4477.619402350804, 4488.8877778055485, 4472.552744725518, 4484.439445069366, 4491.640668746492, 4494.505604383498, 4540.29625408059, 3889.9027524311837, 3971.4241434992055, 3972.086420123359, 3978.76127432355, 3980.7014473914574, 5591.021571225019, 5612.915806262909, 5622.409646987048, 5634.859128521779, 5641.5204707599905, 5295.285136506561, 5298.602604804655, 5299.894002119974, 5300.390455097675, 5305.098133317345, 6054.0, 6169.413905678954, 6217.56477046607, 6328.082428047954, 6344.936550634481, 4340.457442819647, 4357.215701173787, 4365.603007037749, 4371.300591905312, 4378.277584198635, 6564.081028655992, 6568.1789776277965, 6569.901451478184, 6578.3421657834315, 6584.111144995412, 4381.474223093249, 4449.110177964355, 4460.286354183315, 4488.102379524108, 4495.64034877209, 4515.480719717275, 4523.479799822997, 4526.321051842184, 4537.77311134442, 4539.568740969603, 5260.684358938476, 5262.815801447007, 5267.31524901768, 5268.051750684914, 5268.631195816256, 6379.330170332141, 6383.904241436382, 6386.521010924199, 6391.2330520337855, 6397.264314603787, 1580.20199799103, 1597.8641815445817, 1617.6117731744296, 1620.5705488045678, 1620.6272557311884, 1054.6941386997837, 1081.9242653014214, 1083.9891601084046, 1087.0922779479224, 1088.455772113943, 6192.535559833031, 6194.876102477925, 6198.194234749454, 6206.317305096436, 6209.410106039919, 6541.47668186544, 6542.378474044958, 6548.9017664735065, 6553.180852393451, 6554.246261679872, 6071.119687645267, 6161.045038019114, 6169.475594574512, 6180.938190618126, 6186.133941248228, 3525.1715846775987, 3548.7693299935936, 3552.520409744703, 3556.608773035016, 3557.0573797943566, 6749.561278516979, 6814.761483348059, 6815.114035175495, 6815.454763618898, 6816.546043424363, 6711.630860302633, 6733.091032710619, 6739.157605299338, 6740.39336459721, 6748.662566871637, 6706.295838936939, 6869.0383346331555, 6874.381305682413, 6886.51794374399, 6887.173539175331, 6368.554201206057, 6446.8388290293115, 6520.836979075561, 6648.966755166387, 6657.633830139389, 6546.0508226307875, 6559.409653131241, 6574.145361103026, 6576.0, 6583.769568065095, 6764.458843292623, 6867.3476019778045, 6870.038194652652, 6887.552309099892, 6891.138607674041, 4434.445694288214, 4461.866144015685, 4473.955260447354, 4474.082813023258, 4474.821007159677, 6606.504512161511, 6612.272650008399, 6612.867742645024, 6616.206055273398, 6619.735210591522, 6345.809625711236, 6399.168108145911, 6403.0, 6403.775867844603, 6408.166938297992, 6284.245890492987, 6416.550841441241, 6418.133551970424, 6423.004434312689, 6430.614163150039, 6278.309385967631, 6293.118963345044, 6295.842603934938, 6306.369363063657, 6306.527010474325, 6340.4927605792345, 6445.742170313135, 6451.806445806634, 6455.225372955276, 6456.063870738622, 6263.404976527223, 6300.873982520232, 6306.810795676137, 6311.652859092794, 6317.842053948688], "yui.html": [689.2934741889562, 799.1608810748714, 855.3841234311294, 884.1379654836539, 885.8494056010478, 13561.25413102279, 13788.103773254732, 13804.861951380495, 13811.79282310765, 13846.10000349979, 11730.120240981918, 12359.134860559765, 12379.195352302117, 12436.0, 12529.0, 825.1006403020706, 840.1052878684212, 840.2773614691391, 840.3403328387217, 841.2386789955101, 829.4318391901537, 829.8132920092961, 837.137748119435, 837.7026155714725, 838.2162677896156, 875.1511034296722, 876.8202518483696, 877.749841295231, 877.7673916412156, 877.929765618749, 873.0178549132227, 873.5850471026275, 873.8995015573195, 874.8512752832033, 878.9736307910773, 640.8782331357074, 640.8814369341686, 641.1408712325459, 643.5302229372537, 645.6416688737748, 12665.176763510435, 12821.871781282254, 12824.294663793487, 12836.679083022998, 12843.550475733304, 11124.721881952935, 11235.21353505255, 11371.886281137247, 11637.243579167412, 11644.708882278012, 9726.221902247875, 9758.560864761032, 9796.0, 9959.701208963743, 10020.398776073458, 3618.5295911531593, 3628.0385697790107, 3653.6346365363515, 3711.2763011212824, 3779.036345731821, 42392.36411453831, 42598.0, 43694.78152609216, 44903.55096449059, 49068.509314906754, 7270.563766174047, 7393.667284972082, 7468.439867009996, 7571.734989275349, 7747.845043099106, 12007.279563226235, 12042.879571204176, 12069.215500992408, 12085.214461060003, 12105.213161144497, 6923.376896079377, 6941.201761797357, 7021.262767409451, 7062.258462861429, 7093.751718689924, 4558.88602784933, 4564.612007979293, 4596.543367474116, 4600.102979918951, 4649.558291962258, 2685.9597106043425, 2728.399752054545, 2731.098737416648, 2733.931651708723, 2742.1910536391415, 428.3510481620348, 429.44387018810716, 433.21155496995164, 433.8156283579466, 435.4339358833504, 655.8978473990848, 659.7196191618543, 666.6533602123683, 675.6182756742425, 708.6633848921824, 8213.38399620019, 8450.450720703258, 8511.872321915176, 8556.18716221958, 8619.956900215459, 531.3411369901372, 602.8492876780805, 669.2270427656065, 676.0787432889223, 707.0843257980927, 4135.152293779768, 4151.875443736692, 4212.515560710496, 4257.765822879709, 4278.117588316066, 57252.0, 58760.41239587635, 58958.0, 59055.11417328744, 59149.40850591439, 44558.77720611441, 44796.0, 51648.48351516512, 52284.47715522796, 53105.0, 45077.323840142424, 46065.0, 47993.76003120032, 49275.26087108696, 49340.50659493359, 7475.850482990201, 8613.612387442456, 9004.279657627243, 9093.54532273397, 9201.263898887939, 36681.266374672894, 36738.448923266704, 37261.254774903806, 37303.81348093351, 37415.62584374121, 45790.54209457996, 46196.307055393525, 46614.533854662375, 46681.76659116683, 47155.76422117867, 8013.8397232056195, 8040.316573091352, 8158.877616835871, 8228.424010319459, 8344.290735287568, 12708.0, 12742.68143296425, 12776.61670149897, 12925.482980681043, 13331.866681333451, 11395.202335836744, 11460.197786155222, 11649.534018639159, 11924.761504769682, 11961.102917281412, 11220.887791121984, 11291.604793832177, 11519.538342909933, 11569.826452603385, 11874.0, 11080.778384432428, 11258.831117533407, 11495.54017839277, 11838.408079596158, 11864.40677966081, 10048.09567138961, 10070.798584028133, 10294.588216471257, 10328.225383096447, 10418.479076046318, 8914.420562663407, 9435.150836424755, 9587.760305992406, 9606.423614583147, 9714.0]}, "summary": {"lowerIsBetter": false, "suite": 6699.333374363303, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6977.253464290816, "unit": "ms", "value": 6977.253464290816}, "dojo.html": {"lowerIsBetter": false, "filtered": 5401.483609552802, "unit": "ms", "value": 5401.483609552802}, "mootools.html": {"lowerIsBetter": false, "filtered": 4371.556876641124, "unit": "ms", "value": 4371.556876641124}, "ext.html": {"lowerIsBetter": false, "filtered": 18804.68162395046, "unit": "ms", "value": 18804.68162395046}, "prototype.html": {"lowerIsBetter": false, "filtered": 4779.226804237956, "unit": "ms", "value": 4779.226804237956}, "yui.html": {"lowerIsBetter": false, "filtered": 6105.118409022499, "unit": "ms", "value": 6105.118409022499}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447716021, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116133012", "branch": "Mozilla-Inbound", "revision": "85237019374be7a67a2720a5913bfbde64012ebf"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 162.0], "ai-astar": [109.0, 111.0, 105.0, 110.0, 112.0, 112.0, 102.0, 112.0, 112.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "audio-beat-detection": [152.0, 123.0, 152.0, 160.0, 124.0, 150.0, 151.0, 126.0, 170.0, 125.0], "json-stringify-tinderbox": [69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [140.0, 139.0, 148.0, 148.0, 153.0, 140.0, 149.0, 149.0, 150.0, 144.0], "json-parse-financial": [58.0, 58.0, 57.0, 56.0, 58.0, 57.0, 58.0, 64.0, 55.0, 56.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 65.0], "audio-fft": [72.0, 72.0, 72.0, 93.0, 73.0, 71.0, 73.0, 122.0, 92.0, 73.0], "imaging-darkroom": [145.0, 145.0, 144.0, 146.0, 145.0, 147.0, 145.0, 146.0, 145.0, 146.0], "stanford-crypto-ccm": [113.0, 115.0, 119.0, 114.0, 121.0, 117.0, 121.0, 124.0, 116.0, 123.0], "audio-oscillator": [89.0, 89.0, 134.0, 89.0, 90.0, 90.0, 131.0, 90.0, 90.0, 135.0], "stanford-crypto-aes": [84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "imaging-desaturate": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.3, "unit": "ms", "value": 81.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.0, "unit": "ms", "value": 146.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.3, "unit": "ms", "value": 143.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.3, "unit": "ms", "value": 118.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.7, "unit": "ms", "value": 57.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.7, "unit": "ms", "value": 102.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 65.9, "unit": "ms", "value": 65.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.0, "unit": "ms", "value": 109.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.6, "unit": "ms", "value": 84.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.1, "unit": "ms", "value": 95.1}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447716021, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116133012", "branch": "Mozilla-Inbound", "revision": "85237019374be7a67a2720a5913bfbde64012ebf"}}, {"talos_counters": {}, "results": {"DeltaBlue": [194.1747572815534], "Encrypt": [284.09090909090907], "NavierStokes": [4835.748792270531], "Decrypt": [5040.201005025126], "Splay": [568.8282138794084], "Richards": [163.42539630658604], "RegExp": [26025.641025641027], "Earley": [809.0614886731391], "Boyer": [12011.904761904761], "RayTrace": [1106.1946902654868]}, "summary": {"lowerIsBetter": false, "suite": 21137.853740376857, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.50769999999994, "unit": "score", "value": 340.50769999999994}, "Encrypt": {"lowerIsBetter": false, "filtered": 936.95712, "unit": "score", "value": 936.95712}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 143.26117800000003, "unit": "score", "value": 143.26117800000003}, "RegExp": {"lowerIsBetter": false, "filtered": 35.003364532019674, "unit": "score", "value": 35.003364532019674}, "Richards": {"lowerIsBetter": false, "filtered": 216.01293800000005, "unit": "score", "value": 216.01293800000005}, "Earley": {"lowerIsBetter": false, "filtered": 823.7482679999999, "unit": "score", "value": 823.7482679999999}, "Boyer": {"lowerIsBetter": false, "filtered": 55.483540138751295, "unit": "score", "value": 55.483540138751295}, "RayTrace": {"lowerIsBetter": false, "filtered": 668.9500559999998, "unit": "score", "value": 668.9500559999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-008"}, "testrun": {"date": 1447716021, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116133012", "branch": "Mozilla-Inbound", "revision": "85237019374be7a67a2720a5913bfbde64012ebf"}}] 15:40:32 INFO - RETURN: dromaeo_css: 6699.33 15:40:32 INFO - RETURN: kraken: 1489.50 15:40:32 INFO - RETURN: v8_7: 21137.85 15:40:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21137.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1489.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6699.33"}}} 15:40:32 INFO - Return code: 0 15:40:32 INFO - # TBPL SUCCESS # 15:40:32 INFO - Running post-action listener: _resource_record_post_action 15:40:32 INFO - Running post-run listener: _resource_record_post_run 15:40:33 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 514019328; Read time: 0; Write time: 518504 15:40:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 177881088; Read time: 0; Write time: 296832 15:40:33 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 331468800; Read time: 0; Write time: 221300 15:40:33 INFO - Running post-run listener: _upload_blobber_files 15:40:33 INFO - Blob upload gear active. 15:40:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:40:33 INFO - Copying logs to upload dir... 15:40:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.755358 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-16 15:40:33.067279) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:40:33.072047) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010083 build_url: 'https://queue.taskcluster.net/v1/task/CLy9xcZ5RLauys0JV-ULyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 15:40:33.097976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 15:40:33.098297) ========= 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=7d909545e45784438f4e8e36000001b3-1447715883.646-617506730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 1.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 15:40:34.607927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:40:34.608272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 15:40:34.609839) ========= ========= Total master_lag: 1.74 =========