builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1447347688.85 results: success (0) buildid: 20151112073424 builduid: 1cbc7609280941cab8c2b332b94273b3 revision: 62968e4afd68406ee95f0313a51df2cc0964dae8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.847796) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.848206) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.848513) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006656 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.870024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.870337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.892314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.892592) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.949009) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.949288) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.949621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:28.949896) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-12 09:01:30-- 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% 63.8M=0s 2015-11-12 09:01:30 (63.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192213 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.161723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.162047) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016076 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.213172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.213538) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 62968e4afd68406ee95f0313a51df2cc0964dae8 --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 62968e4afd68406ee95f0313a51df2cc0964dae8 --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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-12 09:01:30,631 truncating revision to first 12 chars 2015-11-12 09:01:30,631 Setting DEBUG logging. 2015-11-12 09:01:30,631 attempt 1/10 2015-11-12 09:01:30,631 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/62968e4afd68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-12 09:01:30,871 unpacking tar archive at: mozilla-inbound-62968e4afd68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.742505) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.742808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.750150) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.750419) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-12 09:01:29.750797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-12 09:01:29.751075) ========= /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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:01:31 INFO - MultiFileLogger online at 20151112 09:01:31 in /builds/slave/test-pgo 09:01:31 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 09:01:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:01:31 INFO - {'append_to_log': False, 09:01:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:01:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:01:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:01:31 INFO - 'branch': 'Mozilla-Inbound', 09:01:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:01:31 INFO - 'config_files': ('talos/linux_config.py',), 09:01:31 INFO - 'default_actions': ('clobber', 09:01:31 INFO - 'read-buildbot-config', 09:01:31 INFO - 'download-and-extract', 09:01:31 INFO - 'populate-webroot', 09:01:31 INFO - 'create-virtualenv', 09:01:31 INFO - 'install', 09:01:31 INFO - 'run-tests'), 09:01:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:01:31 INFO - 'download_minidump_stackwalk': True, 09:01:31 INFO - 'download_symbols': 'ondemand', 09:01:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:01:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:01:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:01:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:01:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:01:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:01:31 INFO - 'installer_path': 'installer.exe', 09:01:31 INFO - 'log_level': 'info', 09:01:31 INFO - 'log_name': 'talos', 09:01:31 INFO - 'log_to_console': True, 09:01:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:01:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:01:31 INFO - 'opt_config_files': (), 09:01:31 INFO - 'pip_index': False, 09:01:31 INFO - 'sps_profile': False, 09:01:31 INFO - 'sps_profile_interval': 0, 09:01:31 INFO - 'suite': 'dromaeojs', 09:01:31 INFO - 'system_bits': '64', 09:01:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:01:31 INFO - 'title': 'talos-linux64-ix-065', 09:01:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:01:31 INFO - 'use_talos_json': True, 09:01:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:01:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:01:31 INFO - 'work_dir': 'build'} 09:01:31 INFO - ##### 09:01:31 INFO - ##### Running clobber step. 09:01:31 INFO - ##### 09:01:31 INFO - Running pre-action listener: _resource_record_pre_action 09:01:31 INFO - Running main action method: clobber 09:01:31 INFO - rmtree: /builds/slave/test-pgo/build 09:01:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:01:32 INFO - Running post-action listener: _resource_record_post_action 09:01:32 INFO - ##### 09:01:32 INFO - ##### Running read-buildbot-config step. 09:01:32 INFO - ##### 09:01:32 INFO - Running pre-action listener: _resource_record_pre_action 09:01:32 INFO - Running main action method: read_buildbot_config 09:01:32 INFO - Using buildbot properties: 09:01:32 INFO - { 09:01:32 INFO - "properties": { 09:01:32 INFO - "buildnumber": 547, 09:01:32 INFO - "product": "firefox", 09:01:32 INFO - "script_repo_revision": "production", 09:01:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:01:32 INFO - "repository": "", 09:01:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:01:32 INFO - "buildid": "20151112073424", 09:01:32 INFO - "slavename": "talos-linux64-ix-065", 09:01:32 INFO - "pgo_build": "True", 09:01:32 INFO - "basedir": "/builds/slave/test-pgo", 09:01:32 INFO - "project": "", 09:01:32 INFO - "platform": "ubuntu64_hw", 09:01:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:01:32 INFO - "slavebuilddir": "test", 09:01:32 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:01:32 INFO - "branch": "mozilla-inbound", 09:01:32 INFO - "repo_path": "integration/mozilla-inbound", 09:01:32 INFO - "stage_platform": "linux64-pgo", 09:01:32 INFO - "builduid": "1cbc7609280941cab8c2b332b94273b3", 09:01:32 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:32 INFO - }, 09:01:32 INFO - "sourcestamp": { 09:01:32 INFO - "repository": "", 09:01:32 INFO - "hasPatch": false, 09:01:32 INFO - "project": "", 09:01:32 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:01:32 INFO - "changes": [ 09:01:32 INFO - { 09:01:32 INFO - "category": null, 09:01:32 INFO - "files": [ 09:01:32 INFO - { 09:01:32 INFO - "url": null, 09:01:32 INFO - "name": "https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:01:32 INFO - } 09:01:32 INFO - ], 09:01:32 INFO - "repository": "", 09:01:32 INFO - "rev": "62968e4afd68406ee95f0313a51df2cc0964dae8", 09:01:32 INFO - "who": "sendchange", 09:01:32 INFO - "when": 1447347651, 09:01:32 INFO - "number": 6654001, 09:01:32 INFO - "comments": "", 09:01:32 INFO - "project": "", 09:01:32 INFO - "at": "Thu 12 Nov 2015 09:00:51", 09:01:32 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:01:32 INFO - "revlink": "", 09:01:32 INFO - "properties": [ 09:01:32 INFO - [ 09:01:32 INFO - "buildid", 09:01:32 INFO - "20151112073424", 09:01:32 INFO - "Change" 09:01:32 INFO - ], 09:01:32 INFO - [ 09:01:32 INFO - "builduid", 09:01:32 INFO - "1cbc7609280941cab8c2b332b94273b3", 09:01:32 INFO - "Change" 09:01:32 INFO - ], 09:01:32 INFO - [ 09:01:32 INFO - "pgo_build", 09:01:32 INFO - "True", 09:01:32 INFO - "Change" 09:01:32 INFO - ] 09:01:32 INFO - ], 09:01:32 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:32 INFO - } 09:01:32 INFO - ], 09:01:32 INFO - "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8" 09:01:32 INFO - } 09:01:32 INFO - } 09:01:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:01:32 INFO - Running post-action listener: _resource_record_post_action 09:01:32 INFO - ##### 09:01:32 INFO - ##### Running download-and-extract step. 09:01:32 INFO - ##### 09:01:32 INFO - Running pre-action listener: _resource_record_pre_action 09:01:32 INFO - Running main action method: download_and_extract 09:01:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:32 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json 09:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json 09:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:01:36 INFO - Downloaded 1302 bytes. 09:01:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:01:36 INFO - Using the following test package requirements: 09:01:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:01:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'jsshell-linux-x86_64.zip'], 09:01:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:01:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:01:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:01:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:01:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:01:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:01:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:01:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:36 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:40 INFO - Downloaded 22444207 bytes. 09:01:40 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 09:01:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:40 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 09:01:41 INFO - Return code: 0 09:01:41 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 09:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:41 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:52 INFO - Downloaded 22444207 bytes. 09:01:52 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 09:01:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:01:52 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 09:01:54 INFO - Return code: 0 09:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:54 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:01:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:55 INFO - Downloaded 11131693 bytes. 09:01:55 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 09:01:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:01:55 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 09:01:55 INFO - Return code: 0 09:01: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')]} 09:01:55 INFO - https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:01:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d0FRufNWSByqXIiDOklLrQ/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 09:01:57 INFO - Downloaded 57171457 bytes. 09:01:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:57 INFO - mkdir: /builds/slave/test-pgo/properties 09:01:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:01:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:01:57 INFO - Contents: 09:01:57 INFO - build_url:https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:01:57 INFO - Running post-action listener: _resource_record_post_action 09:01:57 INFO - Running post-action listener: set_extra_try_arguments 09:01:57 INFO - ##### 09:01:57 INFO - ##### Running populate-webroot step. 09:01:57 INFO - ##### 09:01:57 INFO - Running pre-action listener: _resource_record_pre_action 09:01:57 INFO - Running main action method: populate_webroot 09:01:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:01:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:01:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:01:57 INFO - '../fennec_ids.txt'], 09:01:57 INFO - 'tests': ['tcheck2']}, 09:01:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:01:57 INFO - '--tppagecycles', 09:01:57 INFO - '7'], 09:01:57 INFO - 'tests': ['tsvgm']}}, 09:01:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:01:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:01:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:01:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:01:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'tests': ['damp', 'tps']}, 09:01:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['damp', 'tps']}, 09:01:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:01:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:01:57 INFO - 'other': {'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'other_l64': {'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:01:57 INFO - 'ts_paint', 09:01:57 INFO - 'tpaint', 09:01:57 INFO - 'sessionrestore', 09:01:57 INFO - 'sessionrestore_no_auto_restore']}, 09:01:57 INFO - 'svgr': {'tests': ['tsvgx', 09:01:57 INFO - 'tsvgr_opacity', 09:01:57 INFO - 'tart', 09:01:57 INFO - 'tscrollx', 09:01:57 INFO - 'cart']}, 09:01:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['tsvgx', 09:01:57 INFO - 'tsvgr_opacity', 09:01:57 INFO - 'tart', 09:01:57 INFO - 'tscrollx', 09:01:57 INFO - 'cart']}, 09:01:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'tests': ['tp5o']}, 09:01:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'talos_options': ['--e10s'], 09:01:57 INFO - 'tests': ['tp5o']}, 09:01:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'talos_options': ['--xperf_path', 09:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:57 INFO - 'tests': ['tp5n']}, 09:01:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:01:57 INFO - 'talos_options': ['--e10s', 09:01:57 INFO - '--xperf_path', 09:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:01:57 INFO - 'tests': ['tp5n']}}, 09:01:57 INFO - 'talos.zip': {'path': '', 09:01:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:01:57 INFO - Running post-action listener: _resource_record_post_action 09:01:57 INFO - ##### 09:01:57 INFO - ##### Running create-virtualenv step. 09:01:57 INFO - ##### 09:01:57 INFO - Running pre-action listener: _resource_record_pre_action 09:01:57 INFO - Running main action method: create_virtualenv 09:01:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:01:57 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 09:01:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:01:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:01:57 INFO - Using real prefix '/usr' 09:01:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:01:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:01:59 INFO - Installing pip.................done. 09:01:59 INFO - Return code: 0 09:01:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:01:59 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')]} 09:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 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')]} 09:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:01:59 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 09:01:59 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 09:01:59 INFO - Using env: {'DISPLAY': ':0', 09:01:59 INFO - 'HOME': '/home/cltbld', 09:01:59 INFO - 'LANG': 'en_US.UTF-8', 09:01:59 INFO - 'LANGUAGE': 'en_US:en', 09:01:59 INFO - 'LOGNAME': 'cltbld', 09:01:59 INFO - 'MAIL': '/var/mail/cltbld', 09:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:59 INFO - 'MOZ_NO_REMOTE': '1', 09:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:59 INFO - 'NO_EM_RESTART': '1', 09:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:01:59 INFO - 'SHELL': '/bin/bash', 09:01:59 INFO - 'SHLVL': '1', 09:01:59 INFO - 'TERM': 'linux', 09:01:59 INFO - 'TMOUT': '86400', 09:01:59 INFO - 'USER': 'cltbld', 09:01:59 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:59 INFO - '_': '/tools/buildbot/bin/python'} 09:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:59 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 09:01:59 INFO - Cleaning up... 09:01:59 INFO - Return code: 0 09:01:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:01:59 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')]} 09:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 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')]} 09:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:59 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:01:59 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 09:01:59 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 09:01:59 INFO - Using env: {'DISPLAY': ':0', 09:01:59 INFO - 'HOME': '/home/cltbld', 09:01:59 INFO - 'LANG': 'en_US.UTF-8', 09:01:59 INFO - 'LANGUAGE': 'en_US:en', 09:01:59 INFO - 'LOGNAME': 'cltbld', 09:01:59 INFO - 'MAIL': '/var/mail/cltbld', 09:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:59 INFO - 'MOZ_NO_REMOTE': '1', 09:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:01:59 INFO - 'NO_EM_RESTART': '1', 09:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:01:59 INFO - 'SHELL': '/bin/bash', 09:01:59 INFO - 'SHLVL': '1', 09:01:59 INFO - 'TERM': 'linux', 09:01:59 INFO - 'TMOUT': '86400', 09:01:59 INFO - 'USER': 'cltbld', 09:01:59 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:59 INFO - '_': '/tools/buildbot/bin/python'} 09:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:00 INFO - Downloading/unpacking psutil>=0.7.1 09:02:00 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 09:02:00 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 09:02:00 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 09:02:00 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 09:02:00 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 09:02:00 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 09:02:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:01 INFO - Installing collected packages: psutil 09:02:01 INFO - Running setup.py install for psutil 09:02:02 INFO - building 'psutil._psutil_linux' extension 09:02:02 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 09:02:02 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 09:02:02 INFO - building 'psutil._psutil_posix' extension 09:02:02 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 09:02:02 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 09:02:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:02:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:02:02 INFO - Successfully installed psutil 09:02:02 INFO - Cleaning up... 09:02:02 INFO - Return code: 0 09:02:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:02: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')]} 09:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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')]} 09:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02: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', '--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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:02:02 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 09:02:02 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 09:02:02 INFO - Using env: {'DISPLAY': ':0', 09:02:02 INFO - 'HOME': '/home/cltbld', 09:02:02 INFO - 'LANG': 'en_US.UTF-8', 09:02:02 INFO - 'LANGUAGE': 'en_US:en', 09:02:02 INFO - 'LOGNAME': 'cltbld', 09:02:02 INFO - 'MAIL': '/var/mail/cltbld', 09:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:02 INFO - 'MOZ_NO_REMOTE': '1', 09:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:02 INFO - 'NO_EM_RESTART': '1', 09:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:02 INFO - 'SHELL': '/bin/bash', 09:02:02 INFO - 'SHLVL': '1', 09:02:02 INFO - 'TERM': 'linux', 09:02:02 INFO - 'TMOUT': '86400', 09:02:02 INFO - 'USER': 'cltbld', 09:02:02 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:02 INFO - '_': '/tools/buildbot/bin/python'} 09:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:02 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 09:02:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:02:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:02:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:02:04 INFO - Installing collected packages: mozsystemmonitor 09:02:04 INFO - Running setup.py install for mozsystemmonitor 09:02:04 INFO - Successfully installed mozsystemmonitor 09:02:04 INFO - Cleaning up... 09:02:04 INFO - Return code: 0 09:02:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:04 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:02:04 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 09:02:04 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 09:02:04 INFO - Using env: {'DISPLAY': ':0', 09:02:04 INFO - 'HOME': '/home/cltbld', 09:02:04 INFO - 'LANG': 'en_US.UTF-8', 09:02:04 INFO - 'LANGUAGE': 'en_US:en', 09:02:04 INFO - 'LOGNAME': 'cltbld', 09:02:04 INFO - 'MAIL': '/var/mail/cltbld', 09:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:04 INFO - 'MOZ_NO_REMOTE': '1', 09:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:04 INFO - 'NO_EM_RESTART': '1', 09:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:04 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:04 INFO - 'SHELL': '/bin/bash', 09:02:04 INFO - 'SHLVL': '1', 09:02:04 INFO - 'TERM': 'linux', 09:02:04 INFO - 'TMOUT': '86400', 09:02:04 INFO - 'USER': 'cltbld', 09:02:04 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:04 INFO - '_': '/tools/buildbot/bin/python'} 09:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:02:04 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 09:02:04 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 09:02:04 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 09:02:04 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 09:02:04 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 09:02:04 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 09:02:06 INFO - Downloading blobuploader-1.2.4.tar.gz 09:02:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:02:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:02:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:02:07 INFO - Downloading docopt-0.6.1.tar.gz 09:02:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:02:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:02:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:02:07 INFO - Running setup.py install for blobuploader 09:02:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:02:07 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:02:07 INFO - Running setup.py install for requests 09:02:07 INFO - Running setup.py install for docopt 09:02:07 INFO - Successfully installed blobuploader requests docopt 09:02:07 INFO - Cleaning up... 09:02:07 INFO - Return code: 0 09:02:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:07 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:02:07 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 09:02:07 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 09:02:07 INFO - Using env: {'DISPLAY': ':0', 09:02:07 INFO - 'HOME': '/home/cltbld', 09:02:07 INFO - 'LANG': 'en_US.UTF-8', 09:02:07 INFO - 'LANGUAGE': 'en_US:en', 09:02:07 INFO - 'LOGNAME': 'cltbld', 09:02:07 INFO - 'MAIL': '/var/mail/cltbld', 09:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:07 INFO - 'MOZ_NO_REMOTE': '1', 09:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:07 INFO - 'NO_EM_RESTART': '1', 09:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:07 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:07 INFO - 'SHELL': '/bin/bash', 09:02:07 INFO - 'SHLVL': '1', 09:02:07 INFO - 'TERM': 'linux', 09:02:07 INFO - 'TMOUT': '86400', 09:02:07 INFO - 'USER': 'cltbld', 09:02:07 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:07 INFO - '_': '/tools/buildbot/bin/python'} 09:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:07 INFO - Running setup.py (path:/tmp/pip-SUXj0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:08 INFO - Running setup.py (path:/tmp/pip-JB4GcW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:08 INFO - Running setup.py (path:/tmp/pip-B2Nzza-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:08 INFO - Running setup.py (path:/tmp/pip-6gQwQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:08 INFO - Running setup.py (path:/tmp/pip-smLMFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:08 INFO - Running setup.py (path:/tmp/pip-Pa7qRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:08 INFO - Running setup.py (path:/tmp/pip-PoW90w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:08 INFO - Running setup.py (path:/tmp/pip-f81Dry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:08 INFO - Running setup.py (path:/tmp/pip-5xwYbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:08 INFO - Running setup.py (path:/tmp/pip-lUDnGa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:08 INFO - Running setup.py (path:/tmp/pip-6yl_4P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:08 INFO - Running setup.py (path:/tmp/pip-rclnk3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:08 INFO - Running setup.py (path:/tmp/pip-dOtFDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:08 INFO - Running setup.py (path:/tmp/pip-HcWNao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:08 INFO - Running setup.py (path:/tmp/pip-E1gfKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:09 INFO - Running setup.py (path:/tmp/pip-SJ3F2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:09 INFO - Running setup.py (path:/tmp/pip-bd5ONG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:02:09 INFO - Running setup.py install for manifestparser 09:02:09 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:02:09 INFO - Running setup.py install for mozcrash 09:02:09 INFO - Running setup.py install for mozdebug 09:02:09 INFO - Running setup.py install for mozdevice 09:02:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:02:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:02:09 INFO - Running setup.py install for mozfile 09:02:09 INFO - Running setup.py install for mozhttpd 09:02:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:02:09 INFO - Running setup.py install for mozinfo 09:02:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:02:09 INFO - Running setup.py install for mozInstall 09:02:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Running setup.py install for mozleak 09:02:10 INFO - Running setup.py install for mozlog 09:02:10 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Running setup.py install for moznetwork 09:02:10 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Running setup.py install for mozprocess 09:02:10 INFO - Running setup.py install for mozprofile 09:02:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Running setup.py install for mozrunner 09:02:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:02:10 INFO - Running setup.py install for mozscreenshot 09:02:10 INFO - Running setup.py install for moztest 09:02:10 INFO - Running setup.py install for mozversion 09:02:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:02:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:02:11 INFO - Cleaning up... 09:02:11 INFO - Return code: 0 09:02:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:11 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:02:11 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 09:02:11 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 09:02:11 INFO - Using env: {'DISPLAY': ':0', 09:02:11 INFO - 'HOME': '/home/cltbld', 09:02:11 INFO - 'LANG': 'en_US.UTF-8', 09:02:11 INFO - 'LANGUAGE': 'en_US:en', 09:02:11 INFO - 'LOGNAME': 'cltbld', 09:02:11 INFO - 'MAIL': '/var/mail/cltbld', 09:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:11 INFO - 'MOZ_NO_REMOTE': '1', 09:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:11 INFO - 'NO_EM_RESTART': '1', 09:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:11 INFO - 'SHELL': '/bin/bash', 09:02:11 INFO - 'SHLVL': '1', 09:02:11 INFO - 'TERM': 'linux', 09:02:11 INFO - 'TMOUT': '86400', 09:02:11 INFO - 'USER': 'cltbld', 09:02:11 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:11 INFO - '_': '/tools/buildbot/bin/python'} 09:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:11 INFO - Running setup.py (path:/tmp/pip-Xcwwn2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:11 INFO - Running setup.py (path:/tmp/pip-Pdu5rZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:11 INFO - Running setup.py (path:/tmp/pip-qrfT__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:11 INFO - Running setup.py (path:/tmp/pip-NSLATb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:11 INFO - Running setup.py (path:/tmp/pip-0WaYyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:11 INFO - Running setup.py (path:/tmp/pip-OR0V80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:11 INFO - Running setup.py (path:/tmp/pip-dhRZTl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:11 INFO - Running setup.py (path:/tmp/pip-GKt2q5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:11 INFO - Running setup.py (path:/tmp/pip-YwaxNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:11 INFO - Running setup.py (path:/tmp/pip-VdWEFD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:02:11 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)) 09:02:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:11 INFO - Running setup.py (path:/tmp/pip-bjDXb7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:12 INFO - Running setup.py (path:/tmp/pip-SA75Vt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:12 INFO - Running setup.py (path:/tmp/pip-BBt4K4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:12 INFO - Running setup.py (path:/tmp/pip-pjzs8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:12 INFO - Running setup.py (path:/tmp/pip-zu0mxN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:12 INFO - Running setup.py (path:/tmp/pip-btwerG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:02:12 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)) 09:02:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:12 INFO - Running setup.py (path:/tmp/pip-2Q4PMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:02:12 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)) 09:02:12 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)) 09:02:12 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)) 09:02:12 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)) 09:02:12 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)) 09:02:12 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)) 09:02:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:02:12 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 09:02:12 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 09:02:12 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 09:02:12 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 09:02:12 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 09:02:12 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 09:02:14 INFO - Downloading blessings-1.5.1.tar.gz 09:02:14 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 09:02:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:02:14 INFO - Installing collected packages: blessings 09:02:14 INFO - Running setup.py install for blessings 09:02:14 INFO - Successfully installed blessings 09:02:14 INFO - Cleaning up... 09:02:14 INFO - Return code: 0 09:02:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:02:14 INFO - Reading from file tmpfile_stdout 09:02:14 INFO - Current package versions: 09:02:14 INFO - argparse == 1.2.1 09:02:14 INFO - blessings == 1.5.1 09:02:14 INFO - blobuploader == 1.2.4 09:02:14 INFO - docopt == 0.6.1 09:02:14 INFO - manifestparser == 1.1 09:02:14 INFO - mozInstall == 1.12 09:02:14 INFO - mozcrash == 0.16 09:02:14 INFO - mozdebug == 0.1 09:02:14 INFO - mozdevice == 0.47 09:02:14 INFO - mozfile == 1.2 09:02:14 INFO - mozhttpd == 0.7 09:02:14 INFO - mozinfo == 0.9 09:02:14 INFO - mozleak == 0.1 09:02:14 INFO - mozlog == 3.0 09:02:14 INFO - moznetwork == 0.27 09:02:14 INFO - mozprocess == 0.22 09:02:14 INFO - mozprofile == 0.27 09:02:14 INFO - mozrunner == 6.11 09:02:14 INFO - mozscreenshot == 0.1 09:02:14 INFO - mozsystemmonitor == 0.0 09:02:14 INFO - moztest == 0.7 09:02:14 INFO - mozversion == 1.4 09:02:14 INFO - psutil == 3.1.1 09:02:14 INFO - requests == 1.2.3 09:02:14 INFO - wsgiref == 0.1.2 09:02:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:02:14 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 0x7f793f433c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10046c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c56e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, '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': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', '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 09:02:14 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 09:02:14 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 09:02:14 INFO - Using env: {'DISPLAY': ':0', 09:02:14 INFO - 'HOME': '/home/cltbld', 09:02:14 INFO - 'LANG': 'en_US.UTF-8', 09:02:14 INFO - 'LANGUAGE': 'en_US:en', 09:02:14 INFO - 'LOGNAME': 'cltbld', 09:02:14 INFO - 'MAIL': '/var/mail/cltbld', 09:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:14 INFO - 'MOZ_NO_REMOTE': '1', 09:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:14 INFO - 'NO_EM_RESTART': '1', 09:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:14 INFO - 'SHELL': '/bin/bash', 09:02:14 INFO - 'SHLVL': '1', 09:02:14 INFO - 'TERM': 'linux', 09:02:14 INFO - 'TMOUT': '86400', 09:02:14 INFO - 'USER': 'cltbld', 09:02:14 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:14 INFO - '_': '/tools/buildbot/bin/python'} 09:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 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)) 09:02:14 INFO - Cleaning up... 09:02:14 INFO - Return code: 0 09:02:14 INFO - Running post-action listener: _resource_record_post_action 09:02:14 INFO - Running post-action listener: _start_resource_monitoring 09:02:14 INFO - Starting resource monitoring. 09:02:14 INFO - ##### 09:02:14 INFO - ##### Running install step. 09:02:14 INFO - ##### 09:02:14 INFO - Running pre-action listener: _resource_record_pre_action 09:02:14 INFO - Running main action method: install 09:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:02:15 INFO - Reading from file tmpfile_stdout 09:02:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:02:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:02:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:02:15 INFO - Reading from file tmpfile_stdout 09:02:15 INFO - Output received: 09:02:15 INFO - Usage: mozinstall [options] installer 09:02:15 INFO - Options: 09:02:15 INFO - -h, --help show this help message and exit 09:02:15 INFO - -d DEST, --destination=DEST 09:02:15 INFO - Directory to install application into. [default: 09:02:15 INFO - "/builds/slave/test-pgo"] 09:02:15 INFO - --app=APP Application being installed. [default: firefox] 09:02:15 INFO - mkdir: /builds/slave/test-pgo/build/application 09:02:15 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'] 09:02:15 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 09:02:29 INFO - Reading from file tmpfile_stdout 09:02:29 INFO - Output received: 09:02:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:02:29 INFO - Running post-action listener: _resource_record_post_action 09:02:29 INFO - ##### 09:02:29 INFO - ##### Running run-tests step. 09:02:29 INFO - ##### 09:02:29 INFO - Running pre-action listener: _resource_record_pre_action 09:02:29 INFO - Running main action method: run_tests 09:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:02:29 INFO - Python 2.7.3 09:02:29 INFO - Return code: 0 09:02:29 INFO - grabbing minidump binary from tooltool 09:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:02:29 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 0x10fba90>, '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 0x114df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x114e2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:02:29 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 09:02:29 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 09:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:02:29 INFO - Return code: 0 09:02:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:02:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:02:29 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/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:02:29 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/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 09:02:29 INFO - Using env: {'DISPLAY': ':0', 09:02:29 INFO - 'HOME': '/home/cltbld', 09:02:29 INFO - 'LANG': 'en_US.UTF-8', 09:02:29 INFO - 'LANGUAGE': 'en_US:en', 09:02:29 INFO - 'LOGNAME': 'cltbld', 09:02:29 INFO - 'MAIL': '/var/mail/cltbld', 09:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:02:29 INFO - 'MOZ_NO_REMOTE': '1', 09:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:02:29 INFO - 'NO_EM_RESTART': '1', 09:02:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:02:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:02:29 INFO - 'SHELL': '/bin/bash', 09:02:29 INFO - 'SHLVL': '1', 09:02:29 INFO - 'TERM': 'linux', 09:02:29 INFO - 'TMOUT': '86400', 09:02:29 INFO - 'USER': 'cltbld', 09:02:29 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474', 09:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:02:29 INFO - '_': '/tools/buildbot/bin/python'} 09:02:29 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/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 09:02:29 INFO - mozversion INFO | application_buildid: 20151112073424 09:02:29 INFO - mozversion INFO | application_changeset: 62968e4afd68406ee95f0313a51df2cc0964dae8 09:02:29 INFO - mozversion INFO | application_display_name: Nightly 09:02:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:02:29 INFO - mozversion INFO | application_name: Firefox 09:02:29 INFO - mozversion INFO | application_remotingname: firefox 09:02:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:02:29 INFO - mozversion INFO | application_vendor: Mozilla 09:02:29 INFO - mozversion INFO | application_version: 45.0a1 09:02:29 INFO - mozversion INFO | platform_buildid: 20151112073424 09:02:29 INFO - mozversion INFO | platform_changeset: 62968e4afd68406ee95f0313a51df2cc0964dae8 09:02:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:02:29 INFO - mozversion INFO | platform_version: 45.0a1 09:02:29 INFO - 2015-11-12 09:02:29,795 DEBUG : using testdate: 1447347749 09:02:29 INFO - 2015-11-12 09:02:29,795 DEBUG : actual date: 1447347749 09:02:29 INFO - 2015-11-12 09:02:29,805 INFO : starting webserver on 'localhost:36369' 09:02:29 INFO - 2015-11-12 09:02:29,806 INFO : Starting test suite talos-linux64-ix-065 09:02:29 INFO - 2015-11-12 09:02:29,806 INFO : Starting test dromaeo_css 09:02:29 INFO - 2015-11-12 09:02:29,806 DEBUG : operating with platform_type : linux_ 09:02:29 INFO - 2015-11-12 09:02:29,807 INFO : Initialising browser for dromaeo_css test... 09:02:29 INFO - 2015-11-12 09:02:29,822 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLhUpf4/profile http://localhost:36369/getInfo.html 09:02:35 INFO - 2015-11-12 09:02:35,123 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:02:35 INFO - 2015-11-12 09:02:35,124 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:02:35 INFO - 2015-11-12 09:02:35,124 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:02:35 INFO - 2015-11-12 09:02:35,124 DEBUG : BROWSER_OUTPUT: __metrics 09:02:35 INFO - 2015-11-12 09:02:35,205 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:36 INFO - 2015-11-12 09:02:36,743 INFO : Browser initialized. 09:02:36 INFO - 2015-11-12 09:02:36,744 INFO : Running cycle 1/1 for dromaeo_css test... 09:02:36 INFO - 2015-11-12 09:02:36,744 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLhUpf4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:02:48 INFO - 2015-11-12 09:02:48,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 141570048 09:02:48 INFO - 2015-11-12 09:02:48,472 DEBUG : BROWSER_OUTPUT: 09:03:39 INFO - 2015-11-12 09:03:39,343 DEBUG : BROWSER_OUTPUT: 1447347819339 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] 09:05:48 INFO - 2015-11-12 09:05:48,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36369/tests/dromaeo/cssquery-ext.html) 09:05:49 INFO - 2015-11-12 09:05:49,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 235655168 09:05:49 INFO - 2015-11-12 09:05:49,843 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-12 09:08:52,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-ext.html (next: http://localhost:36369/tests/dromaeo/cssquery-jquery.html) 09:08:52 INFO - 2015-11-12 09:08:52,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 220254208 09:08:52 INFO - 2015-11-12 09:08:52,724 DEBUG : BROWSER_OUTPUT: 09:11:54 INFO - 2015-11-12 09:11:54,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36369/tests/dromaeo/cssquery-mootools.html) 09:11:55 INFO - 2015-11-12 09:11:55,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 215224320 09:11:55 INFO - 2015-11-12 09:11:55,198 DEBUG : BROWSER_OUTPUT: 09:14:57 INFO - 2015-11-12 09:14:57,015 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36369/tests/dromaeo/cssquery-prototype.html) 09:14:57 INFO - 2015-11-12 09:14:57,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 200736768 09:14:57 INFO - 2015-11-12 09:14:57,617 DEBUG : BROWSER_OUTPUT: 09:18:00 INFO - 2015-11-12 09:18:00,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36369/tests/dromaeo/cssquery-yui.html) 09:18:00 INFO - 2015-11-12 09:18:00,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 202846208 09:18:00 INFO - 2015-11-12 09:18:00,698 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/dromaeo/cssquery-yui.html (next: http://localhost:36369/tests/dromaeo/cssquery-dojo.html) 09:21:03 INFO - 2015-11-12 09:21:03,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 245993472 09:21:03 INFO - 2015-11-12 09:21:03,587 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:21:03 INFO - 2015-11-12 09:21:03,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:21:03 INFO - 2015-11-12 09:21:03,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:21:03 INFO - 2015-11-12 09:21:03,588 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:21:03 INFO - 2015-11-12 09:21:03,589 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3190.154609028608;3253.9349213015726;3289.8321096010914;3298.785578937369;3314.5856767904006;5321;5457.481539253775;5490.478404551566;5498.67007979521;5538.169274608806;5387.1111266640955;5450;5451.427600101992;5481.095619222833;5536.280283563131;4926.06404783091;4944.629152813535;4970.2296144097545;4972.900541989158;4998.950010499885;4982.153033984213;4989.326440930482;5052.0906236877345;5058.898822023557;5086.542211200991;4838.975805120952;4865.318855360252;4933.531314525115;4958.206686930074;4966.80132794686;4997.85006449807;5015.749212539395;5017.623678224148;5025.296458495814;5057.064443078042;4804.42346918372;5009.924851127236;5015.32293140425;5027.572656324217;5072.695638261679;5201.765920533585;5293.470652934714;5295.179247216649;5315;5339.652922560022;5848.502877255439;5862.413758624146;5866.5893387462465;5867.090600956859;5872.442117998783;5765.509931655814;5873.3245676746865;5880.088586269135;5883.61756485827;5904.232449781501;5474.343078830566;5527.944720552743;5528.115501519777;5528.391876893619;5562.137868630369;5963.910541341883;5981.6710080945095;5985.491233245223;5995.880082398327;5996.640201587918;5726.513246374022;5787.160861675034;5802.303723553201;5806.4193580641595;5854.414558544197;5929.555283353766;5930.2883653960935;5933.792317268875;5936.762529498772;5955.285365756137;5894.852628684317;5902.822915312548;5904.261967254093;5905.822825315247;5919.733611987471;5586.720663966786;5694.629849059798;5772.5670574707065;5909.468147866713;5916.5858389913155;4500.234960056799;4505.301678239878;4536.954630453653;4544.227481328182;4550.840720574764;4022.4368588397647;4023.215472982799;4030.052937559671;4051.6150965658803;4066.898327541835;5419.593530485151;5511.696856672921;5529.474699903502;5618.719064046782;5665;5952.166696662471;5988.760449582055;5991.191189189403;6001.099835024694;6002.759889604455;5449.4005659377435;5599;5614.214010038598;5616.719164041781;5620.437956204347;5050.772715227824;5076.416212135578;5122.692638441706;5127.897442051138;5163.741812909339;6079.483243924316;6082.087686847009;6087.086936959403;6087.269527656709;6088.543359248074;5713.800016999385;5837.066069428871;5863.560232982458;5869.031609784338;5880.147378629989;6010.699465026819;6073.331933487401;6073.848153796191;6074.726637301421;6082.543809214415;5819.301683797971;5836.708164591669;5842.7078646066675;5847.415258474119;5850.268716410449;5690.203371527907;5799.391063938226;5800.709964501673;5895.764169433346;5896.528277737856;5716.971415142898;5720.942790572041;5723.456271654186;5735.971320143372;5865.912011319919;5643.266375371176;5689.630174038674;5691.288588926384;5692.6299790513485;5712.02895507773;5354.678719276856;5461.317335333083;5569.610127291213;5618.381977982501;5689.857753556194;5771;5774.884502310014;5784.595078344475;5790.305163380252;5871.6770577618645;5611.074172761612;5648.039833228278;5658.236138121466;5674;5677.432256774289 09:21:03 INFO - 2015-11-12 09:21:03,591 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.8933862975143;581.6306645280246;584.4068270705234;590.4685782795483;591.9585629005969;30666.84666576667;31198.688013119863;31246.375072498537;39342;39698.20603587934;42034;42164.15671686572;42548;42632.786836065774;42694.78652606733;7604.049493813273;8638.697645582406;8803;8817.206451419372;8818;7612.695492180306;10408.531616077295;10739.78520429591;10741.785164296709;10747.62383316584;10284.228682848816;10388.480575971209;10392.844107338396;10398.584056637725;10401.271910966236;10284.845727314096;10453.477326133663;10470.738231544196;10489.108425783741;10492.685219443429;10208.387496750145;10342.482875856178;10349.58601655933;10355.48222588875;10359.430231337274;39763.80118099391;40178.799106004284;40188;40196.799016004734;40204.59795402038;3266.6406695263504;3388.423967925459;3605;3776.961335632723;3926.6466018058227;29458.705412945812;29760.702392976225;29979.550306745197;30202.09393718192;30295;3377.6115746689197;3384.5430866833153;3410.437277849152;3470.9479357809655;3495.318412909484;280083;280209;280253.99999999796;280538;281185;54035.459645403826;54777.45222547803;55233.72383138059;55524.72237638786;56895;52986.73506632442;53191;53348.46651533512;53477.732611336694;53570.7321463398;12831.871681283254;12987.220766753837;12992.805107923388;13041.478340866448;13047.804282935764;9241.214496767716;9290.396124251902;9377.1091746284;9444.338896277195;9696.127348538665;18569.071546422623;18697;18697.719534206997;18751.624967500575;18791.060446977597;7772.494787838772;8062.355011599058;8071.273585377344;8106.63520141595;8124.187581241828;915.1946287267162;987.7777500062572;1003.3177439341318;1087.282393620207;1098.5770478365887;27815.721842781717;28286.292842678686;28292.292692682848;28465.146045618665;28657.140285791458;1001.7345403468087;1024.0220589337166;1114.136544178252;1122.9438528073563;1131.5643477261315;14549.19979401122;14625.561233163022;14651.706965860623;14760.335784889705;14904;296760;301021;301034;301132;301543;49912;50112.498875011515;50212.497875021516;50222.748886256064;50229.24656130161;1285.8135570342436;1303.4590644882458;1320.0957344219241;1320.9339533023503;1325.1121748428577;23680;26615.201543953714;27158.1852544424;27736.72263277422;27910.441791163656;41259;41761;41792.791036044626;41837;41850.79074604608;255414;257167;257244.42755572955;258082;258677;26420.20739377822;27707.58438623382;30477.580750791454;30682.386352272384;30929.226769330948;36739;37546.624533754315;39961.80019099886;40739;41794;34879.302413951074;35037.299254015285;35155;35189.29621407506;35886;34619.4807077889;34680.479792803635;35096;35141.12147196341;35427.64572354243;34401.827990859885;34471.31057378888;34604.48093278653;34783.82608086943;34915;30072;31933.68066319307;32324.67675323217;32344.676553234167;32352.838235809613;24158.63762043606;24447.144349947666;24541.75458245395;24618;24860.254192374257 09:21:03 INFO - 2015-11-12 09:21:03,594 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.48132912656246;338.68671478882044;339.98300084995776;341.7249114462857;343.6426116838488;14582.927085364585;15005.549833504985;16543.66912661746;16971.490855274347;19126.13932373043;15986.081670199592;16129.112898790561;16322.75515867263;16339.673206535863;16594.83405165948;5354.785808567663;5505.697186654733;5554.750036248358;5572;5572.4706152915405;4059.1881623675235;4170.207660544502;5499.312585926759;5967.8209653710455;6172.105044768506;6009.699515024253;6035.094735789623;6043.184170137041;6044.365341639131;6069.1806606108275;6376.904346434807;6463.256725476536;6530.412262896315;6569.507286953473;6571.57284776488;6220.688965551704;6510.283868774431;6527.314631963671;6534.607923524603;6535.901961470582;21533.784662153335;21673.133074676993;21819;22229;22468.52846186918;2130.808227259554;2157.2449642624956;2199.1093607089156;2205.2391924786084;2252.8197744180425;13671.453141874412;13743.793843092362;14180.149191048467;14286.214258215794;14792.926035369863;1885.3966730646198;1953;1954.4234450837037;1982.2071171531359;1983.1968052938582;61179.08231376533;65530.3446965529;66946;67099.3290067098;67931.66034169847;14611.415543378358;15371.308291126927;15415.84584154144;15563.610909727347;15573.454929077654;24262.75737242605;24330;24412.87793561021;24561.754382456304;24569.385765356008;8110.513369197867;8133.75598732039;8171.305439037629;8191.713290034821;8207.261346478846;6780.627065511444;6820.522563420612;6847.691853866588;6866.313368663094;6877.828054298582;7655.0813902330965;7776.144624091346;7780.78247699403;7785.416093792988;7791.961040194763;2578.5874260118667;2930.384619229943;2966.9554956675233;2982.895598654037;3057.1745628680133;418.79479055262703;431.312057268656;438.7893810970752;440.7844772385456;446.0922023681792;11582.36297003656;11986.101042421853;12009.159358844798;12183.634490965285;12209.755804883853;456.6529437627427;459.68511569574946;470.034079965667;472.4165655415559;498.5762102213162;6423.871522569616;6626.204855417381;6637.435817955431;6655.6339401332425;6674.232463266787;495411;508914;554166;564915;566410;68750;69804;70025;71387.2861271391;77317.61341193259;466.6709969471514;479.3169733130275;498.8727874392079;510.178612433981;522.4592546714208;10111;10289.9485502572;10330.948345258226;10338.328008679411;10553;32226.8402329077;32930;32978.51596678107;33246.667533324355;33309.50035749417;46276;48025;49459;49658.75170624124;49666.50333496763;6484.967575162094;6732.663366831737;6786.69459874297;6788.1175447191545;6813.727450902106;11879.465424055765;12081.758364832478;12172.14794964344;12265.080118990933;12274.447649855956;10239.795204096024;10314;10646.84029739539;10796.56813727442;10978.560857565608;10118.392896426238;10413.635522756667;10596.046355828012;10656.147508199481;10723.785524289626;10086.193104551765;10140.746481338025;10336.328138670962;10921.563137474412;10969.616063437741;6698.296678848651;6737;6838.692258848264;6856.040154378291;6860.03959445668;10672.733181670521;10755.139588833032;10851.620193293513;10974.341539507655;11233.438328083399 09:21:03 INFO - 2015-11-12 09:21:03,594 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1331.7403106394256;1698.3800912666877;1726.6374061447095;1756.5432987423267;1772.2999415230984;6330.145430366899;7243.89134162988;7443.702251909917;7447.218042105568;7454.664540095695;7298.124225092983;7386.889196662054;7404;7411.332980031796;7411.666475008624;1934.796846331136;1973.703944408343;2197.2858820883275;2242.585121752473;2262.954740905181;2262.592733308004;2266.875321857297;2268.2288022072494;2268.3648578397992;2269.943251418711;2192.1669765489173;2241.831862610303;2242.9775702243014;2245.10195921631;2247.2808701215617;1894.0435080284437;1925.0759635375027;2117.481217101812;2176.706144670465;2178.8474806763534;2231.3306008197637;2246.1801442473543;2246.988765056164;2258.570871534403;2290.1984305492942;7617.047869016373;7678.539287642703;7685.23147685227;7686.730964416274;7687.5387476751575;4417.3815665806815;4500.279955207184;4501.189785838547;4514.345419914127;4515.706479078849;2898.231968528342;2941.6322959630047;2989.626296712911;2997.4904266274784;2999.8350090745002;864.1919804982299;883.8718385834082;890.9376343655947;895.4537731983485;1860.48836569943;10296.27926045177;10344.32761870476;10436.478176091165;10463.529141188588;10488.31825931312;3948.0919388540797;4019.7588144711412;4040.212158629039;4156.709030367845;4160.126373461547;8354.58227088643;8372.455790373606;8444.61999210037;8448.873266901;8460.788480288042;4551.658625603093;4552.226121559343;4570.428696412949;4571.908561828811;4573.725576465423;4208.22147902639;4216.852410165629;4221.345691417835;4221.97889010553;4223.5142958559545;3436.398630239698;3479.8608055677996;3482.4776283557667;3487.5291835602375;3504.7196224301993;1077.617445806743;1079.228351728518;1089.9182561307935;1097.7200813792592;1106.0322218059198;1134.8808375120493;1291.4704970961861;1313.7700902342242;1321.5903070048316;1327.157255142972;7235.529690570096;7290.307420795016;7292.927070729331;7302.160251571031;7309.561426314438;1116.9553217871357;1171.7890779659742;1178.7701398227264;1192.1297452859462;1198.526582000105;5589.8602534936135;5687.03320435527;5691.516221121251;5693.373728889819;5705.400932902068;9014.729558113268;9043.77390565228;9210.447373157633;9252.768680783034;9330.346875718635;9091.909080909238;9125.863112053325;9200.401973871676;9237.861432078524;9239.676611318706;7114.253003434565;7163.06880105583;7188.28117188277;7202.927970720226;7236.7828965130075;6959.304069593203;7001.474889383215;7003;7008.264132266038;7010.684519196547;8022.9197708022175;8121.390895682729;8158.8776168356335;8191.549464779494;8196.303314218358;8088;8342.74971750824;8383.916160838558;8389.580520973805;8398.538080405391;6463.57986730861;6490.188726409199;6559.376859198369;6617.933820661732;6635.966820166062;7326.487145899736;7380.151282602569;7397.482176247826;7424.925750742424;7436.814079648052;6854.451643868379;7016.5790052597;7041.577505349491;7075.115610548682;7175.354218120394;6015.4586087252355;6132.632042077311;6784.626845523544;6878.828029299308;7037.683304251424;6946.79159625212;6980.895286570807;6985.965070174617;6987.441004719509;6994.965025174842;6413.967930160319;6442.452391546771;6445.613263204223;6460.806175814733;6470.644114573555;6557.836054098686;6584.144061272195;6598.241202261801;6600.438962688033;6610.735570577123 09:21:03 INFO - 2015-11-12 09:21:03,596 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.1249781898851;295.30161168835696;300.46817133673414;300.80748321074503;303.11490447892146;5978.9701051494685;6037.698115094244;6055.2128223330965;6200.379962003797;6222.284437289713;6018.157457955879;6075.45320921117;6080.1183828344865;6080.756769729217;6088.086786981955;4293.270144075499;4559.316102584606;4566.246569316058;4575.199340115483;4583.243764778816;4425.933610995838;4449.17690227309;4515.209838278304;4515.758166504221;4529.34324522944;4453.84411545596;4456.48750393704;4459.375687403766;4460.286354183331;4461.39771130898;4258.659307255412;4327.956720432787;4390.517043125254;4454.175977444183;4469.888252793674;3881.378979363288;3888.1640447303967;3889.863854765098;3911;3915.2169566086613;5719.799807006776;5752.683602401867;5757.856053598652;5758.42415758425;5762.625429347079;5226.189940559181;5228;5228.241904923765;5232.241325007891;5252.080885844962;6200.534959878028;6333.651649159295;6334.714937827763;6346.714397852108;6363.554551181419;4237.957620423818;4244.745315281093;4245.596668316505;4248.383984322287;4250.723702959298;6604.438622717074;6670.499712521531;6688.83277918056;6694.330566943267;6697.397234248892;4228.471441069866;4367.432233809584;4368;4369.060651959844;4375.584319489707;4385.342198670225;4390.868273951786;4394.670399720034;4395.208862404734;4406.052698669801;5182.274481572583;5182.4299327073995;5188.844334669966;5192.4547922468355;5193.584513239008;6463.773767918195;6472.061551075068;6472.902906456313;6475.7085931133215;6483.384078512534;1524.183949147769;1539.353471541955;1542.930568124437;1550.449590395416;1550.7286224910595;1011.0445628880784;1017.1354348803458;1025.7128004158847;1032.7986042721748;1036.23836480187;6196.287426945869;6201.10084037812;6202.224721909762;6205.782797602063;6212.378762123752;6597.934020659732;6610.636414997125;6620.404163625297;6632.43624291931;6648.434883034899;6161.106639537332;6179.134921111048;6180.536459765535;6188.009918413032;6193.628382297076;3484.3902317094407;3520.876769313113;3525.048236976002;3556.2531868307947;3609.097725568608;6850.6574671266235;6887.104676392037;6895;6912.792616221522;6973.093497845248;6718.7312507499155;6729.05793188954;6738.797836064926;6744.089547911068;6749.6962636681465;6818.249992500821;6958.338957799001;7010.053642758265;7012.298770122947;7022.508424410242;6720.495962802712;6741.988701694785;6750.244936316495;6752.5948443093575;6763.966180169067;6669.83325416849;6669.833254168685;6674.16572928384;6674.332566743286;6675.465962723068;6831.931680683129;6991.9300806993315;6999.580025198505;7001.054857594159;7002.474814389043;4485.775711214492;4526.977365113154;4528.47922488918;4531.3429552714015;4533.957189846288;6603.405693487609;6612.867742645217;6613.900791488228;6616.669166541557;6616.801495955129;6313.147725057059;6414.647194404352;6441.710123044568;6450.41946224842;6501.284858665637;6483.319251478527;6490.123833282447;6490.156279683611;6491.610503369813;6502.804915852532;6384.808455746335;6389.904151437825;6392.264889537762;6392.584482008655;6406;6342.302346741762;6500.967495162494;6502.382273683992;6504.9674751625935;6510.9674451629335;6315.989441689308;6322.841928951813;6325.399087086719;6326.557141000086;6336.366363363627 09:21:03 INFO - 2015-11-12 09:21:03,597 DEBUG : BROWSER_OUTPUT: |5;yui.html;733.6918494232424;736.6979538389261;831.56342919967;832.4381042796111;841.398400143897;15785.684286314281;16085.678286434264;16093.436729714462;16130;16135.11256880871;14098.295085245749;14210.857891421083;14249.78625320621;14261.857381426182;14276.785848212285;657.2441692054128;666.8466252761867;799.4324029938736;805.9032916050082;812.8496228197803;812.3135950122137;814.8329592433566;818.1695578987333;818.979525511861;819.0212695828487;823.2960818500156;852.0371979663004;856;856.2422256303186;857.438377862501;693.3482526425145;705.3686950179612;817.4441379861721;837.2506606587132;843.2284459719349;607.3592360060135;609.065085094378;611.6360765344613;612.8927437698429;614;12337.321447320393;12597.622071337875;12619.116661833676;12624.116311858083;12632.81050784239;9708.17480514157;10118.949405253;10290.485475726184;10322;10631.043206111488;9534.189593884528;9915.40507569541;9919.23876539258;10169.491525423698;10195;3152.936941261162;3225.3226822367333;3260.315333779909;3261.4781634938295;3303.6696330367013;42517.57482425167;42568.78715606433;42963.35554966647;43092.78453607743;43144;6711.089010442566;6970.268121847234;6978.930210697929;7260;7459.216782237895;11178.664640060812;11223.046041086436;11253.099752019818;11274.154438417152;11282.266652667551;6001.279846418458;6036.15493830864;6041.214642096499;6071.817845464555;6276.246850377984;4047.696422768245;4059.4722686051214;4116.876493705194;4122.835086596502;4128.690348223895;2602.7917766579008;2629.395239095019;2635.8813853376646;2640.9867950660123;2652.0982865825326;419.62233989409776;423.54045860241365;430.09465076015164;430.73509791478017;436.15603806634266;590.4685782795433;618.4588485075559;672.5493919074232;680.8195828105556;689.2556039477353;7603.2776886195725;9042.909570904207;9177.174054335143;9228.123328283802;9263;631.311870061635;652.885744994624;702.5924963521145;708.5394493579215;716.3910675925422;3929.757949691516;3933.704972127102;3959.8812035638975;3983.203359328146;4107.363358679409;49854.25218621651;54857.177142342895;55523;55704.72147639236;55852.720736396055;48107.518924811004;48124.75937620289;48394;48936.26595601069;49123.75438122787;43842.56157438448;44223;45289.54710452919;45297;45538.31692524681;8201.83596328082;8423.452475589067;8688;8931.821363572823;8969.461832290084;32924;33248.66751332456;34720.479192811625;35623;35957.820210898775;43205.13589728125;44225.894352641444;44896;45087.54912450833;45385.31922021238;7439.776806695808;7459.40324774006;7479.588622625808;7509.098908131059;7603.9619801900635;11548;11603.535858565563;11768.176227663982;11783.646490605295;11797.76404471923;10671.253012289066;11121;11163.386013769321;11305.71735706614;11440.370779607201;11216.66350009501;11316.886831131584;11350.148738844784;11440.885591143982;11782.293062416282;11165.274257173258;11414.82877756851;11466.369349685847;11734.061275098142;11851.703707407383;9572.56923438461;9594.469269032987;9782.951085244527;9823;9931.950340248253;8792.956035219782;8953.194212520904;9468.763280918032;9649.614015439303;9715.805683886425 09:21:03 INFO - 2015-11-12 09:21:03,597 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:21:03 INFO - 2015-11-12 09:21:03,597 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:21:03 INFO - 2015-11-12 09:21:03,597 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,829 09:21:03 INFO - 2015-11-12 09:21:03,597 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348863586__endTimestamp 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5451.60 Median:5658.24 stddev:606.76 (10.7%) stddev-sans-first:582.11 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: Values: 3190.2 3253.9 3289.8 3298.8 3314.6 5321.0 5457.5 5490.5 5498.7 5538.2 5387.1 5450.0 5451.4 5481.1 5536.3 4926.1 4944.6 4970.2 4972.9 4999.0 4982.2 4989.3 5052.1 5058.9 5086.5 4839.0 4865.3 4933.5 4958.2 4966.8 4997.9 5015.7 5017.6 5025.3 5057.1 4804.4 5009.9 5015.3 5027.6 5072.7 5201.8 5293.5 5295.2 5315.0 5339.7 5848.5 5862.4 5866.6 5867.1 5872.4 5765.5 5873.3 5880.1 5883.6 5904.2 5474.3 5527.9 5528.1 5528.4 5562.1 5963.9 5981.7 5985.5 5995.9 5996.6 5726.5 5787.2 5802.3 5806.4 5854.4 5929.6 5930.3 5933.8 5936.8 5955.3 5894.9 5902.8 5904.3 5905.8 5919.7 5586.7 5694.6 5772.6 5909.5 5916.6 4500.2 4505.3 4537.0 4544.2 4550.8 4022.4 4023.2 4030.1 4051.6 4066.9 5419.6 5511.7 5529.5 5618.7 5665.0 5952.2 5988.8 5991.2 6001.1 6002.8 5449.4 5599.0 5614.2 5616.7 5620.4 5050.8 5076.4 5122.7 5127.9 5163.7 6079.5 6082.1 6087.1 6087.3 6088.5 5713.8 5837.1 5863.6 5869.0 5880.1 6010.7 6073.3 6073.8 6074.7 6082.5 5819.3 5836.7 5842.7 5847.4 5850.3 5690.2 5799.4 5800.7 5895.8 5896.5 5717.0 5720.9 5723.5 5736.0 5865.9 5643.3 5689.6 5691.3 5692.6 5712.0 5354.7 5461.3 5569.6 5618.4 5689.9 5771.0 5774.9 5784.6 5790.3 5871.7 5611.1 5648.0 5658.2 5674.0 5677.4 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,598 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44296.31 Median:31590.03 stddev:72983.10 (231.0%) stddev-sans-first:73114.00 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: Values: 571.9 581.6 584.4 590.5 592.0 30666.8 31198.7 31246.4 39342.0 39698.2 42034.0 42164.2 42548.0 42632.8 42694.8 7604.0 8638.7 8803.0 8817.2 8818.0 7612.7 10408.5 10739.8 10741.8 10747.6 10284.2 10388.5 10392.8 10398.6 10401.3 10284.8 10453.5 10470.7 10489.1 10492.7 10208.4 10342.5 10349.6 10355.5 10359.4 39763.8 40178.8 40188.0 40196.8 40204.6 3266.6 3388.4 3605.0 3777.0 3926.6 29458.7 29760.7 29979.6 30202.1 30295.0 3377.6 3384.5 3410.4 3470.9 3495.3 280083.0 280209.0 280254.0 280538.0 281185.0 54035.5 54777.5 55233.7 55524.7 56895.0 52986.7 53191.0 53348.5 53477.7 53570.7 12831.9 12987.2 12992.8 13041.5 13047.8 9241.2 9290.4 9377.1 9444.3 9696.1 18569.1 18697.0 18697.7 18751.6 18791.1 7772.5 8062.4 8071.3 8106.6 8124.2 915.2 987.8 1003.3 1087.3 1098.6 27815.7 28286.3 28292.3 28465.1 28657.1 1001.7 1024.0 1114.1 1122.9 1131.6 14549.2 14625.6 14651.7 14760.3 14904.0 296760.0 301021.0 301034.0 301132.0 301543.0 49912.0 50112.5 50212.5 50222.7 50229.2 1285.8 1303.5 1320.1 1320.9 1325.1 23680.0 26615.2 27158.2 27736.7 27910.4 41259.0 41761.0 41792.8 41837.0 41850.8 255414.0 257167.0 257244.4 258082.0 258677.0 26420.2 27707.6 30477.6 30682.4 30929.2 36739.0 37546.6 39961.8 40739.0 41794.0 34879.3 35037.3 35155.0 35189.3 35886.0 34619.5 34680.5 35096.0 35141.1 35427.6 34401.8 34471.3 34604.5 34783.8 34915.0 30072.0 31933.7 32324.7 32344.7 32352.8 24158.6 24447.1 24541.8 24618.0 24860.3 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28431.87 Median:4114.70 stddev:88040.72 (2139.7%) stddev-sans-first:88262.41 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: Values: 332.5 338.7 340.0 341.7 343.6 14582.9 15005.5 16543.7 16971.5 19126.1 15986.1 16129.1 16322.8 16339.7 16594.8 5354.8 5505.7 5554.8 5572.0 5572.5 4059.2 4170.2 5499.3 5967.8 6172.1 6009.7 6035.1 6043.2 6044.4 6069.2 6376.9 6463.3 6530.4 6569.5 6571.6 6220.7 6510.3 6527.3 6534.6 6535.9 21533.8 21673.1 21819.0 22229.0 22468.5 2130.8 2157.2 2199.1 2205.2 2252.8 13671.5 13743.8 14180.1 14286.2 14792.9 1885.4 1953.0 1954.4 1982.2 1983.2 61179.1 65530.3 66946.0 67099.3 67931.7 14611.4 15371.3 15415.8 15563.6 15573.5 24262.8 24330.0 24412.9 24561.8 24569.4 8110.5 8133.8 8171.3 8191.7 8207.3 6780.6 6820.5 6847.7 6866.3 6877.8 7655.1 7776.1 7780.8 7785.4 7792.0 2578.6 2930.4 2967.0 2982.9 3057.2 418.8 431.3 438.8 440.8 446.1 11582.4 11986.1 12009.2 12183.6 12209.8 456.7 459.7 470.0 472.4 498.6 6423.9 6626.2 6637.4 6655.6 6674.2 495411.0 508914.0 554166.0 564915.0 566410.0 68750.0 69804.0 70025.0 71387.3 77317.6 466.7 479.3 498.9 510.2 522.5 10111.0 10289.9 10330.9 10338.3 10553.0 32226.8 32930.0 32978.5 33246.7 33309.5 46276.0 48025.0 49459.0 49658.8 49666.5 6485.0 6732.7 6786.7 6788.1 6813.7 11879.5 12081.8 12172.1 12265.1 12274.4 10239.8 10314.0 10646.8 10796.6 10978.6 10118.4 10413.6 10596.0 10656.1 10723.8 10086.2 10140.7 10336.3 10921.6 10969.6 6698.3 6737.0 6838.7 6856.0 6860.0 10672.7 10755.1 10851.6 10974.3 11233.4 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5321.19 Median:6444.03 stddev:2731.88 (42.4%) stddev-sans-first:2723.08 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: Values: 1331.7 1698.4 1726.6 1756.5 1772.3 6330.1 7243.9 7443.7 7447.2 7454.7 7298.1 7386.9 7404.0 7411.3 7411.7 1934.8 1973.7 2197.3 2242.6 2263.0 2262.6 2266.9 2268.2 2268.4 2269.9 2192.2 2241.8 2243.0 2245.1 2247.3 1894.0 1925.1 2117.5 2176.7 2178.8 2231.3 2246.2 2247.0 2258.6 2290.2 7617.0 7678.5 7685.2 7686.7 7687.5 4417.4 4500.3 4501.2 4514.3 4515.7 2898.2 2941.6 2989.6 2997.5 2999.8 864.2 883.9 890.9 895.5 1860.5 10296.3 10344.3 10436.5 10463.5 10488.3 3948.1 4019.8 4040.2 4156.7 4160.1 8354.6 8372.5 8444.6 8448.9 8460.8 4551.7 4552.2 4570.4 4571.9 4573.7 4208.2 4216.9 4221.3 4222.0 4223.5 3436.4 3479.9 3482.5 3487.5 3504.7 1077.6 1079.2 1089.9 1097.7 1106.0 1134.9 1291.5 1313.8 1321.6 1327.2 7235.5 7290.3 7292.9 7302.2 7309.6 1117.0 1171.8 1178.8 1192.1 1198.5 5589.9 5687.0 5691.5 5693.4 5705.4 9014.7 9043.8 9210.4 9252.8 9330.3 9091.9 9125.9 9200.4 9237.9 9239.7 7114.3 7163.1 7188.3 7202.9 7236.8 6959.3 7001.5 7003.0 7008.3 7010.7 8022.9 8121.4 8158.9 8191.5 8196.3 8088.0 8342.7 8383.9 8389.6 8398.5 6463.6 6490.2 6559.4 6617.9 6636.0 7326.5 7380.2 7397.5 7424.9 7436.8 6854.5 7016.6 7041.6 7075.1 7175.4 6015.5 6132.6 6784.6 6878.8 7037.7 6946.8 6980.9 6986.0 6987.4 6995.0 6414.0 6442.5 6445.6 6460.8 6470.6 6557.8 6584.1 6598.2 6600.4 6610.7 09:21:03 INFO - 2015-11-12 09:21:03,600 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,601 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5337.73 Median:6184.27 stddev:1671.67 (27.0%) stddev-sans-first:1632.93 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: Values: 294.1 295.3 300.5 300.8 303.1 5979.0 6037.7 6055.2 6200.4 6222.3 6018.2 6075.5 6080.1 6080.8 6088.1 4293.3 4559.3 4566.2 4575.2 4583.2 4425.9 4449.2 4515.2 4515.8 4529.3 4453.8 4456.5 4459.4 4460.3 4461.4 4258.7 4328.0 4390.5 4454.2 4469.9 3881.4 3888.2 3889.9 3911.0 3915.2 5719.8 5752.7 5757.9 5758.4 5762.6 5226.2 5228.0 5228.2 5232.2 5252.1 6200.5 6333.7 6334.7 6346.7 6363.6 4238.0 4244.7 4245.6 4248.4 4250.7 6604.4 6670.5 6688.8 6694.3 6697.4 4228.5 4367.4 4368.0 4369.1 4375.6 4385.3 4390.9 4394.7 4395.2 4406.1 5182.3 5182.4 5188.8 5192.5 5193.6 6463.8 6472.1 6472.9 6475.7 6483.4 1524.2 1539.4 1542.9 1550.4 1550.7 1011.0 1017.1 1025.7 1032.8 1036.2 6196.3 6201.1 6202.2 6205.8 6212.4 6597.9 6610.6 6620.4 6632.4 6648.4 6161.1 6179.1 6180.5 6188.0 6193.6 3484.4 3520.9 3525.0 3556.3 3609.1 6850.7 6887.1 6895.0 6912.8 6973.1 6718.7 6729.1 6738.8 6744.1 6749.7 6818.2 6958.3 7010.1 7012.3 7022.5 6720.5 6742.0 6750.2 6752.6 6764.0 6669.8 6669.8 6674.2 6674.3 6675.5 6831.9 6991.9 6999.6 7001.1 7002.5 4485.8 4527.0 4528.5 4531.3 4534.0 6603.4 6612.9 6613.9 6616.7 6616.8 6313.1 6414.6 6441.7 6450.4 6501.3 6483.3 6490.1 6490.2 6491.6 6502.8 6384.8 6389.9 6392.3 6392.6 6406.0 6342.3 6501.0 6502.4 6505.0 6511.0 6316.0 6322.8 6325.4 6326.6 6336.4 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12977.74 Median:46822.92 stddev:15211.44 (32.5%) stddev-sans-first:15226.32 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: Values: 733.7 736.7 831.6 832.4 841.4 15785.7 16085.7 16093.4 16130.0 16135.1 14098.3 14210.9 14249.8 14261.9 14276.8 657.2 666.8 799.4 805.9 812.8 812.3 814.8 818.2 819.0 819.0 823.3 852.0 856.0 856.2 857.4 693.3 705.4 817.4 837.3 843.2 607.4 609.1 611.6 612.9 614.0 12337.3 12597.6 12619.1 12624.1 12632.8 9708.2 10118.9 10290.5 10322.0 10631.0 9534.2 9915.4 9919.2 10169.5 10195.0 3152.9 3225.3 3260.3 3261.5 3303.7 42517.6 42568.8 42963.4 43092.8 43144.0 6711.1 6970.3 6978.9 7260.0 7459.2 11178.7 11223.0 11253.1 11274.2 11282.3 6001.3 6036.2 6041.2 6071.8 6276.2 4047.7 4059.5 4116.9 4122.8 4128.7 2602.8 2629.4 2635.9 2641.0 2652.1 419.6 423.5 430.1 430.7 436.2 590.5 618.5 672.5 680.8 689.3 7603.3 9042.9 9177.2 9228.1 9263.0 631.3 652.9 702.6 708.5 716.4 3929.8 3933.7 3959.9 3983.2 4107.4 49854.3 54857.2 55523.0 55704.7 55852.7 48107.5 48124.8 48394.0 48936.3 49123.8 43842.6 44223.0 45289.5 45297.0 45538.3 8201.8 8423.5 8688.0 8931.8 8969.5 32924.0 33248.7 34720.5 35623.0 35957.8 43205.1 44225.9 44896.0 45087.5 45385.3 7439.8 7459.4 7479.6 7509.1 7604.0 11548.0 11603.5 11768.2 11783.6 11797.8 10671.3 11121.0 11163.4 11305.7 11440.4 11216.7 11316.9 11350.1 11440.9 11782.3 11165.3 11414.8 11466.4 11734.1 11851.7 9572.6 9594.5 9783.0 9823.0 9932.0 8793.0 8953.2 9468.8 9649.6 9715.8 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:21:03 INFO - 2015-11-12 09:21:03,602 DEBUG : BROWSER_OUTPUT: 09:21:04 INFO - 2015-11-12 09:21:04,257 INFO : Browser exited with error code: 0 09:21:04 INFO - 2015-11-12 09:21:04,276 INFO : Completed test dromaeo_css (00:18:34) 09:21:04 INFO - 2015-11-12 09:21:04,276 INFO : Starting test kraken 09:21:04 INFO - 2015-11-12 09:21:04,276 DEBUG : operating with platform_type : linux_ 09:21:04 INFO - 2015-11-12 09:21:04,276 INFO : Initialising browser for kraken test... 09:21:04 INFO - 2015-11-12 09:21:04,282 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfFXfA5/profile http://localhost:36369/getInfo.html 09:21:08 INFO - 2015-11-12 09:21:08,404 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:21:08 INFO - 2015-11-12 09:21:08,404 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:21:08 INFO - 2015-11-12 09:21:08,404 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:21:08 INFO - 2015-11-12 09:21:08,405 DEBUG : BROWSER_OUTPUT: __metrics 09:21:08 INFO - 2015-11-12 09:21:08,602 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:21:09 INFO - 2015-11-12 09:21:09,902 INFO : Browser initialized. 09:21:09 INFO - 2015-11-12 09:21:09,902 INFO : Running cycle 1/1 for kraken test... 09:21:09 INFO - 2015-11-12 09:21:09,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfFXfA5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:21:21 INFO - 2015-11-12 09:21:21,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 139046912 09:21:21 INFO - 2015-11-12 09:21:21,617 DEBUG : BROWSER_OUTPUT: 09:21:24 INFO - 2015-11-12 09:21:24,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36369/tests/kraken/driver.html?testName=audio-beat-detection) 09:21:24 INFO - 2015-11-12 09:21:24,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 181661696 09:21:24 INFO - 2015-11-12 09:21:24,630 DEBUG : BROWSER_OUTPUT: 09:21:27 INFO - 2015-11-12 09:21:27,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36369/tests/kraken/driver.html?testName=audio-dft) 09:21:27 INFO - 2015-11-12 09:21:27,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 172408832 09:21:27 INFO - 2015-11-12 09:21:27,747 DEBUG : BROWSER_OUTPUT: 09:21:30 INFO - 2015-11-12 09:21:30,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36369/tests/kraken/driver.html?testName=audio-fft) 09:21:31 INFO - 2015-11-12 09:21:31,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 151441408 09:21:31 INFO - 2015-11-12 09:21:31,172 DEBUG : BROWSER_OUTPUT: 09:21:33 INFO - 2015-11-12 09:21:33,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36369/tests/kraken/driver.html?testName=audio-oscillator) 09:21:33 INFO - 2015-11-12 09:21:33,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 154071040 09:21:33 INFO - 2015-11-12 09:21:33,736 DEBUG : BROWSER_OUTPUT: 09:21:35 INFO - 2015-11-12 09:21:35,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:21:36 INFO - 2015-11-12 09:21:36,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 155336704 09:21:36 INFO - 2015-11-12 09:21:36,455 DEBUG : BROWSER_OUTPUT: 09:21:39 INFO - 2015-11-12 09:21:39,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36369/tests/kraken/driver.html?testName=imaging-darkroom) 09:21:39 INFO - 2015-11-12 09:21:39,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 155004928 09:21:39 INFO - 2015-11-12 09:21:39,963 DEBUG : BROWSER_OUTPUT: 09:21:43 INFO - 2015-11-12 09:21:43,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36369/tests/kraken/driver.html?testName=imaging-desaturate) 09:21:43 INFO - 2015-11-12 09:21:43,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 09:21:43 INFO - 2015-11-12 09:21:43,932 DEBUG : BROWSER_OUTPUT: 09:21:46 INFO - 2015-11-12 09:21:46,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36369/tests/kraken/driver.html?testName=json-parse-financial) 09:21:47 INFO - 2015-11-12 09:21:47,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 155512832 09:21:47 INFO - 2015-11-12 09:21:47,263 DEBUG : BROWSER_OUTPUT: 09:21:48 INFO - 2015-11-12 09:21:48,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:49 INFO - 2015-11-12 09:21:49,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 167362560 09:21:49 INFO - 2015-11-12 09:21:49,404 DEBUG : BROWSER_OUTPUT: 09:21:51 INFO - 2015-11-12 09:21:51,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:51 INFO - 2015-11-12 09:21:51,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 165928960 09:21:51 INFO - 2015-11-12 09:21:51,781 DEBUG : BROWSER_OUTPUT: 09:21:53 INFO - 2015-11-12 09:21:53,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:54 INFO - 2015-11-12 09:21:54,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 177041408 09:21:54 INFO - 2015-11-12 09:21:54,419 DEBUG : BROWSER_OUTPUT: 09:21:56 INFO - 2015-11-12 09:21:56,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:57 INFO - 2015-11-12 09:21:57,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 182370304 09:21:57 INFO - 2015-11-12 09:21:57,382 DEBUG : BROWSER_OUTPUT: 09:21:59 INFO - 2015-11-12 09:21:59,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:22:00 INFO - 2015-11-12 09:22:00,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 181063680 09:22:00 INFO - 2015-11-12 09:22:00,486 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36369/tests/kraken/driver.html?testName=ai-astar) 09:22:02 INFO - 2015-11-12 09:22:02,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 239198208 09:22:02 INFO - 2015-11-12 09:22:02,393 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;109;110;111;98;110;111;108 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;130;147;158;126;148;144;124;161;125 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;162;161;161;161;162;162;162;161 09:22:02 INFO - 2015-11-12 09:22:02,397 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;80;94;73;73;72;102;89;72 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;136;90;91;92;134;90;92;136 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;110;109;110;109;110 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;145;147;145;147;145;147;146;146 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;95;95;96;95 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;58;59;57;58;60;67;56;56 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;67;68;67;67;67;68 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;90;85;85;87;86;87;86;87 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;116;117;115;116;130;119;126;124;123 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;151;150;152;138;151;148;163;140 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;67;66;68;67;70;65;69 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,920 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348922395__endTimestamp 09:22:02 INFO - 2015-11-12 09:22:02,398 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:4.16 (3.8%) stddev-sans-first:4.41 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 109.0 110.0 111.0 98.0 110.0 111.0 108.0 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.50 stddev:13.89 (9.4%) stddev-sans-first:14.45 09:22:02 INFO - 2015-11-12 09:22:02,400 DEBUG : BROWSER_OUTPUT: Values: 149.0 130.0 147.0 158.0 126.0 148.0 144.0 124.0 161.0 125.0 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 162.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:11.13 (15.2%) stddev-sans-first:11.43 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 80.0 94.0 73.0 73.0 72.0 102.0 89.0 72.0 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,401 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:91.00 stddev:21.37 (23.5%) stddev-sans-first:22.10 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 136.0 90.0 91.0 92.0 134.0 90.0 92.0 136.0 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 145.0 147.0 145.0 147.0 145.0 147.0 146.0 146.0 09:22:02 INFO - 2015-11-12 09:22:02,402 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,403 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 09:22:02 INFO - 2015-11-12 09:22:02,403 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 09:22:02 INFO - 2015-11-12 09:22:02,403 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,403 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.00 stddev:3.24 (5.6%) stddev-sans-first:3.39 09:22:02 INFO - 2015-11-12 09:22:02,403 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 58.0 59.0 57.0 58.0 60.0 67.0 56.0 56.0 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 68.0 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.50 stddev:1.81 (2.1%) stddev-sans-first:1.51 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 90.0 85.0 85.0 87.0 86.0 87.0 86.0 87.0 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:122.00 stddev:4.99 (4.1%) stddev-sans-first:5.29 09:22:02 INFO - 2015-11-12 09:22:02,404 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 117.0 115.0 116.0 130.0 119.0 126.0 124.0 123.0 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:150.50 stddev:7.53 (5.0%) stddev-sans-first:7.71 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 151.0 150.0 152.0 138.0 151.0 148.0 163.0 140.0 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.50 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 66.0 68.0 67.0 70.0 65.0 69.0 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:02 INFO - 2015-11-12 09:22:02,405 DEBUG : BROWSER_OUTPUT: 09:22:03 INFO - 2015-11-12 09:22:03,334 INFO : Browser exited with error code: 0 09:22:03 INFO - 2015-11-12 09:22:03,518 INFO : Completed test kraken (00:00:59) 09:22:03 INFO - 2015-11-12 09:22:03,519 INFO : Starting test v8_7 09:22:03 INFO - 2015-11-12 09:22:03,519 DEBUG : operating with platform_type : linux_ 09:22:03 INFO - 2015-11-12 09:22:03,519 INFO : Initialising browser for v8_7 test... 09:22:03 INFO - 2015-11-12 09:22:03,525 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp74QTWe/profile http://localhost:36369/getInfo.html 09:22:07 INFO - 2015-11-12 09:22:07,567 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:22:07 INFO - 2015-11-12 09:22:07,567 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:22:07 INFO - 2015-11-12 09:22:07,567 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:22:07 INFO - 2015-11-12 09:22:07,567 DEBUG : BROWSER_OUTPUT: __metrics 09:22:07 INFO - 2015-11-12 09:22:07,712 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:08 INFO - 2015-11-12 09:22:08,994 INFO : Browser initialized. 09:22:08 INFO - 2015-11-12 09:22:08,995 INFO : Running cycle 1/1 for v8_7 test... 09:22:08 INFO - 2015-11-12 09:22:08,995 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp74QTWe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:22:20 INFO - 2015-11-12 09:22:20,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 141348864 09:22:20 INFO - 2015-11-12 09:22:20,763 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36369/tests/v8_7/run.html (next: http://localhost:36369/tests/v8_7/run.html) 09:22:42 INFO - 2015-11-12 09:22:42,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 627544064 09:22:42 INFO - 2015-11-12 09:22:42,426 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,426 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:22:42 INFO - 2015-11-12 09:22:42,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |0;Richards;163.88069485414618 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.72292096865027 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 09:22:42 INFO - 2015-11-12 09:22:42,427 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1107.4197120708748 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: |8;Splay;649.8708010335918 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: __startTimestamp1447348962418__endTimestamp 09:22:42 INFO - 2015-11-12 09:22:42,428 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.88 Median:163.88 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: Values: 163.9 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,429 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: Values: 187.7 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: Values: 283.1 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,430 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: Values: 5055.6 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: Values: 1107.4 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: Values: 788.0 09:22:42 INFO - 2015-11-12 09:22:42,431 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: Values: 11988.1 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: Values: 26076.9 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,432 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:649.87 Median:649.87 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: Values: 649.9 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: Values: 4822.1 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:22:42 INFO - 2015-11-12 09:22:42,433 DEBUG : BROWSER_OUTPUT: 09:22:43 INFO - 2015-11-12 09:22:43,314 INFO : Browser exited with error code: 0 09:22:43 INFO - 2015-11-12 09:22:43,330 INFO : Completed test v8_7 (00:00:39) 09:22:43 INFO - 2015-11-12 09:22:43,431 INFO : Completed test suite (00:20:13) 09:22:43 INFO - 2015-11-12 09:22:43,431 DEBUG : Working with test: dromaeo_css 09:22:43 INFO - 2015-11-12 09:22:43,432 DEBUG : Generating results file: dromaeo_css 09:22:43 INFO - 2015-11-12 09:22:43,433 DEBUG : Working with test: kraken 09:22:43 INFO - 2015-11-12 09:22:43,433 DEBUG : Generating results file: kraken 09:22:43 INFO - 2015-11-12 09:22:43,433 INFO : javascript benchmark 09:22:43 INFO - 2015-11-12 09:22:43,433 DEBUG : Working with test: v8_7 09:22:43 INFO - 2015-11-12 09:22:43,433 DEBUG : Generating results file: v8_7 09:22:43 INFO - 2015-11-12 09:22:43,434 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:43 INFO - 2015-11-12 09:22:43,484 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 09:22:43 INFO - 2015-11-12 09:22:43,484 DEBUG : process_Request line: dromaeo_css 6811.47 graph.html#tests=[[72,63,35]] 09:22:43 INFO - 2015-11-12 09:22:43,484 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:43 INFO - 2015-11-12 09:22:43,515 DEBUG : process_Request line: kraken 1493.40 graph.html#tests=[[232,63,35]] 09:22:43 INFO - 2015-11-12 09:22:43,515 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:22:43 INFO - 2015-11-12 09:22:43,550 DEBUG : process_Request line: v8_7 20983.79 graph.html#tests=[[230,63,35]] 09:22:43 INFO - 2015-11-12 09:22:43,552 INFO : javascript benchmark 09:22:43 INFO - 2015-11-12 09:22:43,556 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [332.48132912656246, 338.68671478882044, 339.98300084995776, 341.7249114462857, 343.6426116838488, 14582.927085364585, 15005.549833504985, 16543.66912661746, 16971.490855274347, 19126.13932373043, 15986.081670199592, 16129.112898790561, 16322.75515867263, 16339.673206535863, 16594.83405165948, 5354.785808567663, 5505.697186654733, 5554.750036248358, 5572.0, 5572.4706152915405, 4059.1881623675235, 4170.207660544502, 5499.312585926759, 5967.8209653710455, 6172.105044768506, 6009.699515024253, 6035.094735789623, 6043.184170137041, 6044.365341639131, 6069.1806606108275, 6376.904346434807, 6463.256725476536, 6530.412262896315, 6569.507286953473, 6571.57284776488, 6220.688965551704, 6510.283868774431, 6527.314631963671, 6534.607923524603, 6535.901961470582, 21533.784662153335, 21673.133074676993, 21819.0, 22229.0, 22468.52846186918, 2130.808227259554, 2157.2449642624956, 2199.1093607089156, 2205.2391924786084, 2252.8197744180425, 13671.453141874412, 13743.793843092362, 14180.149191048467, 14286.214258215794, 14792.926035369863, 1885.3966730646198, 1953.0, 1954.4234450837037, 1982.2071171531359, 1983.1968052938582, 61179.08231376533, 65530.3446965529, 66946.0, 67099.3290067098, 67931.66034169847, 14611.415543378358, 15371.308291126927, 15415.84584154144, 15563.610909727347, 15573.454929077654, 24262.75737242605, 24330.0, 24412.87793561021, 24561.754382456304, 24569.385765356008, 8110.513369197867, 8133.75598732039, 8171.305439037629, 8191.713290034821, 8207.261346478846, 6780.627065511444, 6820.522563420612, 6847.691853866588, 6866.313368663094, 6877.828054298582, 7655.0813902330965, 7776.144624091346, 7780.78247699403, 7785.416093792988, 7791.961040194763, 2578.5874260118667, 2930.384619229943, 2966.9554956675233, 2982.895598654037, 3057.1745628680133, 418.79479055262703, 431.312057268656, 438.7893810970752, 440.7844772385456, 446.0922023681792, 11582.36297003656, 11986.101042421853, 12009.159358844798, 12183.634490965285, 12209.755804883853, 456.6529437627427, 459.68511569574946, 470.034079965667, 472.4165655415559, 498.5762102213162, 6423.871522569616, 6626.204855417381, 6637.435817955431, 6655.6339401332425, 6674.232463266787, 495411.0, 508914.0, 554166.0, 564915.0, 566410.0, 68750.0, 69804.0, 70025.0, 71387.2861271391, 77317.61341193259, 466.6709969471514, 479.3169733130275, 498.8727874392079, 510.178612433981, 522.4592546714208, 10111.0, 10289.9485502572, 10330.948345258226, 10338.328008679411, 10553.0, 32226.8402329077, 32930.0, 32978.51596678107, 33246.667533324355, 33309.50035749417, 46276.0, 48025.0, 49459.0, 49658.75170624124, 49666.50333496763, 6484.967575162094, 6732.663366831737, 6786.69459874297, 6788.1175447191545, 6813.727450902106, 11879.465424055765, 12081.758364832478, 12172.14794964344, 12265.080118990933, 12274.447649855956, 10239.795204096024, 10314.0, 10646.84029739539, 10796.56813727442, 10978.560857565608, 10118.392896426238, 10413.635522756667, 10596.046355828012, 10656.147508199481, 10723.785524289626, 10086.193104551765, 10140.746481338025, 10336.328138670962, 10921.563137474412, 10969.616063437741, 6698.296678848651, 6737.0, 6838.692258848264, 6856.040154378291, 6860.03959445668, 10672.733181670521, 10755.139588833032, 10851.620193293513, 10974.341539507655, 11233.438328083399], "dojo.html": [3190.154609028608, 3253.9349213015726, 3289.8321096010914, 3298.785578937369, 3314.5856767904006, 5321.0, 5457.481539253775, 5490.478404551566, 5498.67007979521, 5538.169274608806, 5387.1111266640955, 5450.0, 5451.427600101992, 5481.095619222833, 5536.280283563131, 4926.06404783091, 4944.629152813535, 4970.2296144097545, 4972.900541989158, 4998.950010499885, 4982.153033984213, 4989.326440930482, 5052.0906236877345, 5058.898822023557, 5086.542211200991, 4838.975805120952, 4865.318855360252, 4933.531314525115, 4958.206686930074, 4966.80132794686, 4997.85006449807, 5015.749212539395, 5017.623678224148, 5025.296458495814, 5057.064443078042, 4804.42346918372, 5009.924851127236, 5015.32293140425, 5027.572656324217, 5072.695638261679, 5201.765920533585, 5293.470652934714, 5295.179247216649, 5315.0, 5339.652922560022, 5848.502877255439, 5862.413758624146, 5866.5893387462465, 5867.090600956859, 5872.442117998783, 5765.509931655814, 5873.3245676746865, 5880.088586269135, 5883.61756485827, 5904.232449781501, 5474.343078830566, 5527.944720552743, 5528.115501519777, 5528.391876893619, 5562.137868630369, 5963.910541341883, 5981.6710080945095, 5985.491233245223, 5995.880082398327, 5996.640201587918, 5726.513246374022, 5787.160861675034, 5802.303723553201, 5806.4193580641595, 5854.414558544197, 5929.555283353766, 5930.2883653960935, 5933.792317268875, 5936.762529498772, 5955.285365756137, 5894.852628684317, 5902.822915312548, 5904.261967254093, 5905.822825315247, 5919.733611987471, 5586.720663966786, 5694.629849059798, 5772.5670574707065, 5909.468147866713, 5916.5858389913155, 4500.234960056799, 4505.301678239878, 4536.954630453653, 4544.227481328182, 4550.840720574764, 4022.4368588397647, 4023.215472982799, 4030.052937559671, 4051.6150965658803, 4066.898327541835, 5419.593530485151, 5511.696856672921, 5529.474699903502, 5618.719064046782, 5665.0, 5952.166696662471, 5988.760449582055, 5991.191189189403, 6001.099835024694, 6002.759889604455, 5449.4005659377435, 5599.0, 5614.214010038598, 5616.719164041781, 5620.437956204347, 5050.772715227824, 5076.416212135578, 5122.692638441706, 5127.897442051138, 5163.741812909339, 6079.483243924316, 6082.087686847009, 6087.086936959403, 6087.269527656709, 6088.543359248074, 5713.800016999385, 5837.066069428871, 5863.560232982458, 5869.031609784338, 5880.147378629989, 6010.699465026819, 6073.331933487401, 6073.848153796191, 6074.726637301421, 6082.543809214415, 5819.301683797971, 5836.708164591669, 5842.7078646066675, 5847.415258474119, 5850.268716410449, 5690.203371527907, 5799.391063938226, 5800.709964501673, 5895.764169433346, 5896.528277737856, 5716.971415142898, 5720.942790572041, 5723.456271654186, 5735.971320143372, 5865.912011319919, 5643.266375371176, 5689.630174038674, 5691.288588926384, 5692.6299790513485, 5712.02895507773, 5354.678719276856, 5461.317335333083, 5569.610127291213, 5618.381977982501, 5689.857753556194, 5771.0, 5774.884502310014, 5784.595078344475, 5790.305163380252, 5871.6770577618645, 5611.074172761612, 5648.039833228278, 5658.236138121466, 5674.0, 5677.432256774289], "mootools.html": [1331.7403106394256, 1698.3800912666877, 1726.6374061447095, 1756.5432987423267, 1772.2999415230984, 6330.145430366899, 7243.89134162988, 7443.702251909917, 7447.218042105568, 7454.664540095695, 7298.124225092983, 7386.889196662054, 7404.0, 7411.332980031796, 7411.666475008624, 1934.796846331136, 1973.703944408343, 2197.2858820883275, 2242.585121752473, 2262.954740905181, 2262.592733308004, 2266.875321857297, 2268.2288022072494, 2268.3648578397992, 2269.943251418711, 2192.1669765489173, 2241.831862610303, 2242.9775702243014, 2245.10195921631, 2247.2808701215617, 1894.0435080284437, 1925.0759635375027, 2117.481217101812, 2176.706144670465, 2178.8474806763534, 2231.3306008197637, 2246.1801442473543, 2246.988765056164, 2258.570871534403, 2290.1984305492942, 7617.047869016373, 7678.539287642703, 7685.23147685227, 7686.730964416274, 7687.5387476751575, 4417.3815665806815, 4500.279955207184, 4501.189785838547, 4514.345419914127, 4515.706479078849, 2898.231968528342, 2941.6322959630047, 2989.626296712911, 2997.4904266274784, 2999.8350090745002, 864.1919804982299, 883.8718385834082, 890.9376343655947, 895.4537731983485, 1860.48836569943, 10296.27926045177, 10344.32761870476, 10436.478176091165, 10463.529141188588, 10488.31825931312, 3948.0919388540797, 4019.7588144711412, 4040.212158629039, 4156.709030367845, 4160.126373461547, 8354.58227088643, 8372.455790373606, 8444.61999210037, 8448.873266901, 8460.788480288042, 4551.658625603093, 4552.226121559343, 4570.428696412949, 4571.908561828811, 4573.725576465423, 4208.22147902639, 4216.852410165629, 4221.345691417835, 4221.97889010553, 4223.5142958559545, 3436.398630239698, 3479.8608055677996, 3482.4776283557667, 3487.5291835602375, 3504.7196224301993, 1077.617445806743, 1079.228351728518, 1089.9182561307935, 1097.7200813792592, 1106.0322218059198, 1134.8808375120493, 1291.4704970961861, 1313.7700902342242, 1321.5903070048316, 1327.157255142972, 7235.529690570096, 7290.307420795016, 7292.927070729331, 7302.160251571031, 7309.561426314438, 1116.9553217871357, 1171.7890779659742, 1178.7701398227264, 1192.1297452859462, 1198.526582000105, 5589.8602534936135, 5687.03320435527, 5691.516221121251, 5693.373728889819, 5705.400932902068, 9014.729558113268, 9043.77390565228, 9210.447373157633, 9252.768680783034, 9330.346875718635, 9091.909080909238, 9125.863112053325, 9200.401973871676, 9237.861432078524, 9239.676611318706, 7114.253003434565, 7163.06880105583, 7188.28117188277, 7202.927970720226, 7236.7828965130075, 6959.304069593203, 7001.474889383215, 7003.0, 7008.264132266038, 7010.684519196547, 8022.9197708022175, 8121.390895682729, 8158.8776168356335, 8191.549464779494, 8196.303314218358, 8088.0, 8342.74971750824, 8383.916160838558, 8389.580520973805, 8398.538080405391, 6463.57986730861, 6490.188726409199, 6559.376859198369, 6617.933820661732, 6635.966820166062, 7326.487145899736, 7380.151282602569, 7397.482176247826, 7424.925750742424, 7436.814079648052, 6854.451643868379, 7016.5790052597, 7041.577505349491, 7075.115610548682, 7175.354218120394, 6015.4586087252355, 6132.632042077311, 6784.626845523544, 6878.828029299308, 7037.683304251424, 6946.79159625212, 6980.895286570807, 6985.965070174617, 6987.441004719509, 6994.965025174842, 6413.967930160319, 6442.452391546771, 6445.613263204223, 6460.806175814733, 6470.644114573555, 6557.836054098686, 6584.144061272195, 6598.241202261801, 6600.438962688033, 6610.735570577123], "ext.html": [571.8933862975143, 581.6306645280246, 584.4068270705234, 590.4685782795483, 591.9585629005969, 30666.84666576667, 31198.688013119863, 31246.375072498537, 39342.0, 39698.20603587934, 42034.0, 42164.15671686572, 42548.0, 42632.786836065774, 42694.78652606733, 7604.049493813273, 8638.697645582406, 8803.0, 8817.206451419372, 8818.0, 7612.695492180306, 10408.531616077295, 10739.78520429591, 10741.785164296709, 10747.62383316584, 10284.228682848816, 10388.480575971209, 10392.844107338396, 10398.584056637725, 10401.271910966236, 10284.845727314096, 10453.477326133663, 10470.738231544196, 10489.108425783741, 10492.685219443429, 10208.387496750145, 10342.482875856178, 10349.58601655933, 10355.48222588875, 10359.430231337274, 39763.80118099391, 40178.799106004284, 40188.0, 40196.799016004734, 40204.59795402038, 3266.6406695263504, 3388.423967925459, 3605.0, 3776.961335632723, 3926.6466018058227, 29458.705412945812, 29760.702392976225, 29979.550306745197, 30202.09393718192, 30295.0, 3377.6115746689197, 3384.5430866833153, 3410.437277849152, 3470.9479357809655, 3495.318412909484, 280083.0, 280209.0, 280253.99999999796, 280538.0, 281185.0, 54035.459645403826, 54777.45222547803, 55233.72383138059, 55524.72237638786, 56895.0, 52986.73506632442, 53191.0, 53348.46651533512, 53477.732611336694, 53570.7321463398, 12831.871681283254, 12987.220766753837, 12992.805107923388, 13041.478340866448, 13047.804282935764, 9241.214496767716, 9290.396124251902, 9377.1091746284, 9444.338896277195, 9696.127348538665, 18569.071546422623, 18697.0, 18697.719534206997, 18751.624967500575, 18791.060446977597, 7772.494787838772, 8062.355011599058, 8071.273585377344, 8106.63520141595, 8124.187581241828, 915.1946287267162, 987.7777500062572, 1003.3177439341318, 1087.282393620207, 1098.5770478365887, 27815.721842781717, 28286.292842678686, 28292.292692682848, 28465.146045618665, 28657.140285791458, 1001.7345403468087, 1024.0220589337166, 1114.136544178252, 1122.9438528073563, 1131.5643477261315, 14549.19979401122, 14625.561233163022, 14651.706965860623, 14760.335784889705, 14904.0, 296760.0, 301021.0, 301034.0, 301132.0, 301543.0, 49912.0, 50112.498875011515, 50212.497875021516, 50222.748886256064, 50229.24656130161, 1285.8135570342436, 1303.4590644882458, 1320.0957344219241, 1320.9339533023503, 1325.1121748428577, 23680.0, 26615.201543953714, 27158.1852544424, 27736.72263277422, 27910.441791163656, 41259.0, 41761.0, 41792.791036044626, 41837.0, 41850.79074604608, 255414.0, 257167.0, 257244.42755572955, 258082.0, 258677.0, 26420.20739377822, 27707.58438623382, 30477.580750791454, 30682.386352272384, 30929.226769330948, 36739.0, 37546.624533754315, 39961.80019099886, 40739.0, 41794.0, 34879.302413951074, 35037.299254015285, 35155.0, 35189.29621407506, 35886.0, 34619.4807077889, 34680.479792803635, 35096.0, 35141.12147196341, 35427.64572354243, 34401.827990859885, 34471.31057378888, 34604.48093278653, 34783.82608086943, 34915.0, 30072.0, 31933.68066319307, 32324.67675323217, 32344.676553234167, 32352.838235809613, 24158.63762043606, 24447.144349947666, 24541.75458245395, 24618.0, 24860.254192374257], "prototype.html": [294.1249781898851, 295.30161168835696, 300.46817133673414, 300.80748321074503, 303.11490447892146, 5978.9701051494685, 6037.698115094244, 6055.2128223330965, 6200.379962003797, 6222.284437289713, 6018.157457955879, 6075.45320921117, 6080.1183828344865, 6080.756769729217, 6088.086786981955, 4293.270144075499, 4559.316102584606, 4566.246569316058, 4575.199340115483, 4583.243764778816, 4425.933610995838, 4449.17690227309, 4515.209838278304, 4515.758166504221, 4529.34324522944, 4453.84411545596, 4456.48750393704, 4459.375687403766, 4460.286354183331, 4461.39771130898, 4258.659307255412, 4327.956720432787, 4390.517043125254, 4454.175977444183, 4469.888252793674, 3881.378979363288, 3888.1640447303967, 3889.863854765098, 3911.0, 3915.2169566086613, 5719.799807006776, 5752.683602401867, 5757.856053598652, 5758.42415758425, 5762.625429347079, 5226.189940559181, 5228.0, 5228.241904923765, 5232.241325007891, 5252.080885844962, 6200.534959878028, 6333.651649159295, 6334.714937827763, 6346.714397852108, 6363.554551181419, 4237.957620423818, 4244.745315281093, 4245.596668316505, 4248.383984322287, 4250.723702959298, 6604.438622717074, 6670.499712521531, 6688.83277918056, 6694.330566943267, 6697.397234248892, 4228.471441069866, 4367.432233809584, 4368.0, 4369.060651959844, 4375.584319489707, 4385.342198670225, 4390.868273951786, 4394.670399720034, 4395.208862404734, 4406.052698669801, 5182.274481572583, 5182.4299327073995, 5188.844334669966, 5192.4547922468355, 5193.584513239008, 6463.773767918195, 6472.061551075068, 6472.902906456313, 6475.7085931133215, 6483.384078512534, 1524.183949147769, 1539.353471541955, 1542.930568124437, 1550.449590395416, 1550.7286224910595, 1011.0445628880784, 1017.1354348803458, 1025.7128004158847, 1032.7986042721748, 1036.23836480187, 6196.287426945869, 6201.10084037812, 6202.224721909762, 6205.782797602063, 6212.378762123752, 6597.934020659732, 6610.636414997125, 6620.404163625297, 6632.43624291931, 6648.434883034899, 6161.106639537332, 6179.134921111048, 6180.536459765535, 6188.009918413032, 6193.628382297076, 3484.3902317094407, 3520.876769313113, 3525.048236976002, 3556.2531868307947, 3609.097725568608, 6850.6574671266235, 6887.104676392037, 6895.0, 6912.792616221522, 6973.093497845248, 6718.7312507499155, 6729.05793188954, 6738.797836064926, 6744.089547911068, 6749.6962636681465, 6818.249992500821, 6958.338957799001, 7010.053642758265, 7012.298770122947, 7022.508424410242, 6720.495962802712, 6741.988701694785, 6750.244936316495, 6752.5948443093575, 6763.966180169067, 6669.83325416849, 6669.833254168685, 6674.16572928384, 6674.332566743286, 6675.465962723068, 6831.931680683129, 6991.9300806993315, 6999.580025198505, 7001.054857594159, 7002.474814389043, 4485.775711214492, 4526.977365113154, 4528.47922488918, 4531.3429552714015, 4533.957189846288, 6603.405693487609, 6612.867742645217, 6613.900791488228, 6616.669166541557, 6616.801495955129, 6313.147725057059, 6414.647194404352, 6441.710123044568, 6450.41946224842, 6501.284858665637, 6483.319251478527, 6490.123833282447, 6490.156279683611, 6491.610503369813, 6502.804915852532, 6384.808455746335, 6389.904151437825, 6392.264889537762, 6392.584482008655, 6406.0, 6342.302346741762, 6500.967495162494, 6502.382273683992, 6504.9674751625935, 6510.9674451629335, 6315.989441689308, 6322.841928951813, 6325.399087086719, 6326.557141000086, 6336.366363363627], "yui.html": [733.6918494232424, 736.6979538389261, 831.56342919967, 832.4381042796111, 841.398400143897, 15785.684286314281, 16085.678286434264, 16093.436729714462, 16130.0, 16135.11256880871, 14098.295085245749, 14210.857891421083, 14249.78625320621, 14261.857381426182, 14276.785848212285, 657.2441692054128, 666.8466252761867, 799.4324029938736, 805.9032916050082, 812.8496228197803, 812.3135950122137, 814.8329592433566, 818.1695578987333, 818.979525511861, 819.0212695828487, 823.2960818500156, 852.0371979663004, 856.0, 856.2422256303186, 857.438377862501, 693.3482526425145, 705.3686950179612, 817.4441379861721, 837.2506606587132, 843.2284459719349, 607.3592360060135, 609.065085094378, 611.6360765344613, 612.8927437698429, 614.0, 12337.321447320393, 12597.622071337875, 12619.116661833676, 12624.116311858083, 12632.81050784239, 9708.17480514157, 10118.949405253, 10290.485475726184, 10322.0, 10631.043206111488, 9534.189593884528, 9915.40507569541, 9919.23876539258, 10169.491525423698, 10195.0, 3152.936941261162, 3225.3226822367333, 3260.315333779909, 3261.4781634938295, 3303.6696330367013, 42517.57482425167, 42568.78715606433, 42963.35554966647, 43092.78453607743, 43144.0, 6711.089010442566, 6970.268121847234, 6978.930210697929, 7260.0, 7459.216782237895, 11178.664640060812, 11223.046041086436, 11253.099752019818, 11274.154438417152, 11282.266652667551, 6001.279846418458, 6036.15493830864, 6041.214642096499, 6071.817845464555, 6276.246850377984, 4047.696422768245, 4059.4722686051214, 4116.876493705194, 4122.835086596502, 4128.690348223895, 2602.7917766579008, 2629.395239095019, 2635.8813853376646, 2640.9867950660123, 2652.0982865825326, 419.62233989409776, 423.54045860241365, 430.09465076015164, 430.73509791478017, 436.15603806634266, 590.4685782795433, 618.4588485075559, 672.5493919074232, 680.8195828105556, 689.2556039477353, 7603.2776886195725, 9042.909570904207, 9177.174054335143, 9228.123328283802, 9263.0, 631.311870061635, 652.885744994624, 702.5924963521145, 708.5394493579215, 716.3910675925422, 3929.757949691516, 3933.704972127102, 3959.8812035638975, 3983.203359328146, 4107.363358679409, 49854.25218621651, 54857.177142342895, 55523.0, 55704.72147639236, 55852.720736396055, 48107.518924811004, 48124.75937620289, 48394.0, 48936.26595601069, 49123.75438122787, 43842.56157438448, 44223.0, 45289.54710452919, 45297.0, 45538.31692524681, 8201.83596328082, 8423.452475589067, 8688.0, 8931.821363572823, 8969.461832290084, 32924.0, 33248.66751332456, 34720.479192811625, 35623.0, 35957.820210898775, 43205.13589728125, 44225.894352641444, 44896.0, 45087.54912450833, 45385.31922021238, 7439.776806695808, 7459.40324774006, 7479.588622625808, 7509.098908131059, 7603.9619801900635, 11548.0, 11603.535858565563, 11768.176227663982, 11783.646490605295, 11797.76404471923, 10671.253012289066, 11121.0, 11163.386013769321, 11305.71735706614, 11440.370779607201, 11216.66350009501, 11316.886831131584, 11350.148738844784, 11440.885591143982, 11782.293062416282, 11165.274257173258, 11414.82877756851, 11466.369349685847, 11734.061275098142, 11851.703707407383, 9572.56923438461, 9594.469269032987, 9782.951085244527, 9823.0, 9931.950340248253, 8792.956035219782, 8953.194212520904, 9468.763280918032, 9649.614015439303, 9715.805683886425]}, "summary": {"lowerIsBetter": false, "suite": 6811.466396926458, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8249.635442365694, "unit": "ms", "value": 8249.635442365694}, "dojo.html": {"lowerIsBetter": false, "filtered": 5412.095475449138, "unit": "ms", "value": 5412.095475449138}, "mootools.html": {"lowerIsBetter": false, "filtered": 4401.726385570459, "unit": "ms", "value": 4401.726385570459}, "ext.html": {"lowerIsBetter": false, "filtered": 18080.895171587094, "unit": "ms", "value": 18080.895171587094}, "prototype.html": {"lowerIsBetter": false, "filtered": 4775.085972082389, "unit": "ms", "value": 4775.085972082389}, "yui.html": {"lowerIsBetter": false, "filtered": 5885.4759514607185, "unit": "ms", "value": 5885.4759514607185}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-065"}, "testrun": {"date": 1447347749, "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": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 164.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0], "ai-astar": [108.0, 110.0, 103.0, 109.0, 110.0, 111.0, 98.0, 110.0, 111.0, 108.0], "imaging-gaussian-blur": [109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "audio-beat-detection": [149.0, 130.0, 147.0, 158.0, 126.0, 148.0, 144.0, 124.0, 161.0, 125.0], "json-stringify-tinderbox": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [142.0, 141.0, 151.0, 150.0, 152.0, 138.0, 151.0, 148.0, 163.0, 140.0], "json-parse-financial": [57.0, 57.0, 58.0, 59.0, 57.0, 58.0, 60.0, 67.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [67.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 70.0, 65.0, 69.0], "audio-fft": [72.0, 72.0, 80.0, 94.0, 73.0, 73.0, 72.0, 102.0, 89.0, 72.0], "imaging-darkroom": [147.0, 146.0, 145.0, 147.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0], "stanford-crypto-ccm": [121.0, 116.0, 117.0, 115.0, 116.0, 130.0, 119.0, 126.0, 124.0, 123.0], "audio-oscillator": [91.0, 92.0, 136.0, 90.0, 91.0, 92.0, 134.0, 90.0, 92.0, 136.0], "stanford-crypto-aes": [83.0, 86.0, 90.0, 85.0, 85.0, 87.0, 86.0, 87.0, 86.0, 87.0], "imaging-desaturate": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1493.3999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.9, "unit": "ms", "value": 79.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.6, "unit": "ms", "value": 147.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 141.2, "unit": "ms", "value": 141.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.7, "unit": "ms", "value": 120.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.1, "unit": "ms", "value": 146.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 58.5, "unit": "ms", "value": 58.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.4, "unit": "ms", "value": 104.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.8, "unit": "ms", "value": 107.8}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.2, "unit": "ms", "value": 86.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-065"}, "testrun": {"date": 1447347749, "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": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}, {"talos_counters": {}, "results": {"DeltaBlue": [187.72292096865027], "Encrypt": [283.12570781426956], "NavierStokes": [4822.115384615385], "Decrypt": [5055.555555555556], "Splay": [649.8708010335918], "Richards": [163.88069485414618], "RegExp": [26076.923076923078], "Earley": [788.0220646178093], "Boyer": [11988.095238095239], "RayTrace": [1107.4197120708748]}, "summary": {"lowerIsBetter": false, "suite": 20983.788815230462, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 352.210586, "unit": "score", "value": 352.210586}, "Encrypt": {"lowerIsBetter": false, "filtered": 940.1512919999999, "unit": "score", "value": 940.1512919999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.7487537387835, "unit": "score", "value": 307.7487537387835}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.65118681318681, "unit": "score", "value": 52.65118681318681}, "Splay": {"lowerIsBetter": false, "filtered": 125.3956938369781, "unit": "score", "value": 125.3956938369781}, "RegExp": {"lowerIsBetter": false, "filtered": 34.934528023598794, "unit": "score", "value": 34.934528023598794}, "Richards": {"lowerIsBetter": false, "filtered": 215.4128039999999, "unit": "score", "value": 215.4128039999999}, "Earley": {"lowerIsBetter": false, "filtered": 845.7415470000001, "unit": "score", "value": 845.7415470000001}, "Boyer": {"lowerIsBetter": false, "filtered": 55.59373584905661, "unit": "score", "value": 55.59373584905661}, "RayTrace": {"lowerIsBetter": false, "filtered": 668.2100670000003, "unit": "score", "value": 668.2100670000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-065"}, "testrun": {"date": 1447347749, "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": "20151112073424", "branch": "Mozilla-Inbound", "revision": "62968e4afd68406ee95f0313a51df2cc0964dae8"}}] 09:22:43 INFO - RETURN: dromaeo_css: 6811.47 09:22:43 INFO - RETURN: kraken: 1493.40 09:22:43 INFO - RETURN: v8_7: 20983.79 09:22:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20983.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1493.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6811.47"}}} 09:22:43 INFO - Return code: 0 09:22:43 INFO - # TBPL SUCCESS # 09:22:43 INFO - Running post-action listener: _resource_record_post_action 09:22:43 INFO - Running post-run listener: _resource_record_post_run 09:22:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507514880; Read time: 8; Write time: 464848 09:22:44 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 164286464; Read time: 0; Write time: 147156 09:22:44 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 343228416; Read time: 0; Write time: 317692 09:22:44 INFO - Running post-run listener: _upload_blobber_files 09:22:44 INFO - Blob upload gear active. 09:22:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:22:44 INFO - Copying logs to upload dir... 09:22:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.643261 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-12 09:22:43.397170) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:43.400509) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/d0FRufNWSByqXIiDOklLrQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:43.451844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:43.452409) ========= 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=20aa3857bbc5a756c598c738000001bb-1447347567.368682-174713474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-12 09:22:43.501890) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:22:43.502211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-12 09:22:43.502494) ========= ========= Total master_lag: 0.22 =========