builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1447793789.45 results: success (0) buildid: 20151117113016 builduid: cad48acd8d064efc8f7ace312de1894d revision: 3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.455225) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.455715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.456007) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006477 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.504744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.508185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.567769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.568051) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004614 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.627340) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.627671) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.628074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.628409) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 12:56: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% 212M=0s 2015-11-17 12:56:30 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145455 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.812247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.812812) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017744 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:29.886158) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 12:56:29.886537) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726 --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/fx-team --rev 3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726 --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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 12:56:30,336 truncating revision to first 12 chars 2015-11-17 12:56:30,337 Setting DEBUG logging. 2015-11-17 12:56:30,337 attempt 1/10 2015-11-17 12:56:30,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b0264d42bf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 12:56:31,311 unpacking tar archive at: fx-team-3b0264d42bf5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256665 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 12:56:31.171384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:31.171686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:31.181352) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:31.181707) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 12:56:31.182163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-17 12:56:31.182451) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:31 INFO - MultiFileLogger online at 20151117 12:56:31 in /builds/slave/test-pgo 12:56:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:56:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:56:31 INFO - {'append_to_log': False, 12:56:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:56:31 INFO - 'blob_upload_branch': 'Fx-Team', 12:56:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:56:31 INFO - 'branch': 'Fx-Team', 12:56:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:31 INFO - 'config_files': ('talos/linux_config.py',), 12:56:31 INFO - 'default_actions': ('clobber', 12:56:31 INFO - 'read-buildbot-config', 12:56:31 INFO - 'download-and-extract', 12:56:31 INFO - 'populate-webroot', 12:56:31 INFO - 'create-virtualenv', 12:56:31 INFO - 'install', 12:56:31 INFO - 'run-tests'), 12:56:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:31 INFO - 'download_minidump_stackwalk': True, 12:56:31 INFO - 'download_symbols': 'ondemand', 12:56:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:31 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:31 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:31 INFO - 'installer_path': 'installer.exe', 12:56:31 INFO - 'log_level': 'info', 12:56:31 INFO - 'log_name': 'talos', 12:56:31 INFO - 'log_to_console': True, 12:56:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:31 INFO - 'opt_config_files': (), 12:56:31 INFO - 'pip_index': False, 12:56:31 INFO - 'sps_profile': False, 12:56:31 INFO - 'sps_profile_interval': 0, 12:56:31 INFO - 'suite': 'dromaeojs', 12:56:31 INFO - 'system_bits': '64', 12:56:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:31 INFO - 'title': 'talos-linux64-ix-041', 12:56:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:31 INFO - 'use_talos_json': True, 12:56:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:56:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:31 INFO - 'work_dir': 'build'} 12:56:31 INFO - ##### 12:56:31 INFO - ##### Running clobber step. 12:56:31 INFO - ##### 12:56:31 INFO - Running pre-action listener: _resource_record_pre_action 12:56:31 INFO - Running main action method: clobber 12:56:31 INFO - rmtree: /builds/slave/test-pgo/build 12:56:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:56:32 INFO - Running post-action listener: _resource_record_post_action 12:56:32 INFO - ##### 12:56:32 INFO - ##### Running read-buildbot-config step. 12:56:32 INFO - ##### 12:56:32 INFO - Running pre-action listener: _resource_record_pre_action 12:56:32 INFO - Running main action method: read_buildbot_config 12:56:32 INFO - Using buildbot properties: 12:56:32 INFO - { 12:56:32 INFO - "properties": { 12:56:32 INFO - "buildnumber": 494, 12:56:32 INFO - "product": "firefox", 12:56:32 INFO - "script_repo_revision": "production", 12:56:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:56:32 INFO - "repository": "", 12:56:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:56:32 INFO - "buildid": "20151117113016", 12:56:32 INFO - "slavename": "talos-linux64-ix-041", 12:56:32 INFO - "pgo_build": "True", 12:56:32 INFO - "basedir": "/builds/slave/test-pgo", 12:56:32 INFO - "project": "", 12:56:32 INFO - "platform": "ubuntu64_hw", 12:56:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:56:32 INFO - "slavebuilddir": "test", 12:56:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:56:32 INFO - "branch": "fx-team", 12:56:32 INFO - "repo_path": "integration/fx-team", 12:56:32 INFO - "stage_platform": "linux64-pgo", 12:56:32 INFO - "builduid": "cad48acd8d064efc8f7ace312de1894d", 12:56:32 INFO - "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726" 12:56:32 INFO - }, 12:56:32 INFO - "sourcestamp": { 12:56:32 INFO - "repository": "", 12:56:32 INFO - "hasPatch": false, 12:56:32 INFO - "project": "", 12:56:32 INFO - "branch": "fx-team-linux64-pgo-talos", 12:56:32 INFO - "changes": [ 12:56:32 INFO - { 12:56:32 INFO - "category": null, 12:56:32 INFO - "files": [ 12:56:32 INFO - { 12:56:32 INFO - "url": null, 12:56:32 INFO - "name": "https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:56:32 INFO - } 12:56:32 INFO - ], 12:56:32 INFO - "repository": "", 12:56:32 INFO - "rev": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726", 12:56:32 INFO - "who": "sendchange", 12:56:32 INFO - "when": 1447793779, 12:56:32 INFO - "number": 6673610, 12:56:32 INFO - "comments": "", 12:56:32 INFO - "project": "", 12:56:32 INFO - "at": "Tue 17 Nov 2015 12:56:19", 12:56:32 INFO - "branch": "fx-team-linux64-pgo-talos", 12:56:32 INFO - "revlink": "", 12:56:32 INFO - "properties": [ 12:56:32 INFO - [ 12:56:32 INFO - "buildid", 12:56:32 INFO - "20151117113016", 12:56:32 INFO - "Change" 12:56:32 INFO - ], 12:56:32 INFO - [ 12:56:32 INFO - "builduid", 12:56:32 INFO - "cad48acd8d064efc8f7ace312de1894d", 12:56:32 INFO - "Change" 12:56:32 INFO - ], 12:56:32 INFO - [ 12:56:32 INFO - "pgo_build", 12:56:32 INFO - "True", 12:56:32 INFO - "Change" 12:56:32 INFO - ] 12:56:32 INFO - ], 12:56:32 INFO - "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726" 12:56:32 INFO - } 12:56:32 INFO - ], 12:56:32 INFO - "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726" 12:56:32 INFO - } 12:56:32 INFO - } 12:56:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:56:32 INFO - Running post-action listener: _resource_record_post_action 12:56:32 INFO - ##### 12:56:32 INFO - ##### Running download-and-extract step. 12:56:32 INFO - ##### 12:56:32 INFO - Running pre-action listener: _resource_record_pre_action 12:56:32 INFO - Running main action method: download_and_extract 12:56:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:56: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')]} 12:56:32 INFO - https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/test_packages.json 12:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/test_packages.json 12:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:56:33 INFO - Downloaded 1302 bytes. 12:56:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:56:33 INFO - Using the following test package requirements: 12:56:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'jsshell-linux-x86_64.zip'], 12:56:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:56:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:56:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:33 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')]} 12:56:33 INFO - https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:34 INFO - Downloaded 22458992 bytes. 12:56:34 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 12:56:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:34 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 12:56:36 INFO - Return code: 0 12:56:36 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 12:56: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')]} 12:56:36 INFO - https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:45 INFO - Downloaded 22458992 bytes. 12:56:45 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 12:56:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:56:45 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 12:56:46 INFO - Return code: 0 12:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:46 INFO - https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:48 INFO - Downloaded 11131693 bytes. 12:56:48 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 12:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:48 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 12:56:49 INFO - Return code: 0 12:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:49 INFO - https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QhKaBopFQFOHBE6nTLVcIA/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 12:56:52 INFO - Downloaded 57181949 bytes. 12:56:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:56:52 INFO - mkdir: /builds/slave/test-pgo/properties 12:56:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:56:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:56:52 INFO - Contents: 12:56:52 INFO - build_url:https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:56:52 INFO - Running post-action listener: _resource_record_post_action 12:56:52 INFO - Running post-action listener: set_extra_try_arguments 12:56:52 INFO - ##### 12:56:52 INFO - ##### Running populate-webroot step. 12:56:52 INFO - ##### 12:56:52 INFO - Running pre-action listener: _resource_record_pre_action 12:56:52 INFO - Running main action method: populate_webroot 12:56:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:56:52 INFO - '../fennec_ids.txt'], 12:56:52 INFO - 'tests': ['tcheck2']}, 12:56:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:52 INFO - '--tppagecycles', 12:56:52 INFO - '7'], 12:56:52 INFO - 'tests': ['tsvgm']}}, 12:56:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:56:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'tests': ['damp', 'tps']}, 12:56:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['damp', 'tps']}, 12:56:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:56:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:52 INFO - 'other': {'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'other_l64': {'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'other_nol64': {'tests': ['a11yr', 12:56:52 INFO - 'ts_paint', 12:56:52 INFO - 'tpaint', 12:56:52 INFO - 'sessionrestore', 12:56:52 INFO - 'sessionrestore_no_auto_restore']}, 12:56:52 INFO - 'svgr': {'tests': ['tsvgx', 12:56:52 INFO - 'tsvgr_opacity', 12:56:52 INFO - 'tart', 12:56:52 INFO - 'tscrollx', 12:56:52 INFO - 'cart']}, 12:56:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['tsvgx', 12:56:52 INFO - 'tsvgr_opacity', 12:56:52 INFO - 'tart', 12:56:52 INFO - 'tscrollx', 12:56:52 INFO - 'cart']}, 12:56:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'tests': ['tp5o']}, 12:56:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'talos_options': ['--e10s'], 12:56:52 INFO - 'tests': ['tp5o']}, 12:56:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'talos_options': ['--xperf_path', 12:56:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:52 INFO - 'tests': ['tp5n']}, 12:56:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:52 INFO - 'talos_options': ['--e10s', 12:56:52 INFO - '--xperf_path', 12:56:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:52 INFO - 'tests': ['tp5n']}}, 12:56:52 INFO - 'talos.zip': {'path': '', 12:56:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:52 INFO - Running post-action listener: _resource_record_post_action 12:56:52 INFO - ##### 12:56:52 INFO - ##### Running create-virtualenv step. 12:56:52 INFO - ##### 12:56:52 INFO - Running pre-action listener: _resource_record_pre_action 12:56:52 INFO - Running main action method: create_virtualenv 12:56:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:56:52 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 12:56:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:56:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:53 INFO - Using real prefix '/usr' 12:56:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:56:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:55 INFO - Installing pip.................done. 12:56:55 INFO - Return code: 0 12:56:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:56: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')]} 12:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:56:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:56:55 INFO - Using env: {'DISPLAY': ':0', 12:56:55 INFO - 'HOME': '/home/cltbld', 12:56:55 INFO - 'LANG': 'en_US.UTF-8', 12:56:55 INFO - 'LANGUAGE': 'en_US:en', 12:56:55 INFO - 'LOGNAME': 'cltbld', 12:56:55 INFO - 'MAIL': '/var/mail/cltbld', 12:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:55 INFO - 'MOZ_NO_REMOTE': '1', 12:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:55 INFO - 'NO_EM_RESTART': '1', 12:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:55 INFO - 'SHELL': '/bin/bash', 12:56:55 INFO - 'SHLVL': '1', 12:56:55 INFO - 'TERM': 'linux', 12:56:55 INFO - 'TMOUT': '86400', 12:56:55 INFO - 'USER': 'cltbld', 12:56:55 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:55 INFO - '_': '/tools/buildbot/bin/python'} 12:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:55 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 12:56:55 INFO - Cleaning up... 12:56:55 INFO - Return code: 0 12:56:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:56: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')]} 12:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56: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')]} 12:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:56:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:56:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:56:55 INFO - Using env: {'DISPLAY': ':0', 12:56:55 INFO - 'HOME': '/home/cltbld', 12:56:55 INFO - 'LANG': 'en_US.UTF-8', 12:56:55 INFO - 'LANGUAGE': 'en_US:en', 12:56:55 INFO - 'LOGNAME': 'cltbld', 12:56:55 INFO - 'MAIL': '/var/mail/cltbld', 12:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:55 INFO - 'MOZ_NO_REMOTE': '1', 12:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:55 INFO - 'NO_EM_RESTART': '1', 12:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:55 INFO - 'SHELL': '/bin/bash', 12:56:55 INFO - 'SHLVL': '1', 12:56:55 INFO - 'TERM': 'linux', 12:56:55 INFO - 'TMOUT': '86400', 12:56:55 INFO - 'USER': 'cltbld', 12:56:55 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:55 INFO - '_': '/tools/buildbot/bin/python'} 12:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:55 INFO - Downloading/unpacking psutil>=0.7.1 12:56:55 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 12:56:55 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 12:56:55 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 12:56:55 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 12:56:55 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 12:56:55 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 12:56:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:56:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:57 INFO - Installing collected packages: psutil 12:56:57 INFO - Running setup.py install for psutil 12:56:57 INFO - building 'psutil._psutil_linux' extension 12:56:57 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 12:56:57 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 12:56:57 INFO - building 'psutil._psutil_posix' extension 12:56:57 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 12:56:58 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 12:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:58 INFO - Successfully installed psutil 12:56:58 INFO - Cleaning up... 12:56:58 INFO - Return code: 0 12:56:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:58 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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:56:58 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 12:56:58 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 12:56:58 INFO - Using env: {'DISPLAY': ':0', 12:56:58 INFO - 'HOME': '/home/cltbld', 12:56:58 INFO - 'LANG': 'en_US.UTF-8', 12:56:58 INFO - 'LANGUAGE': 'en_US:en', 12:56:58 INFO - 'LOGNAME': 'cltbld', 12:56:58 INFO - 'MAIL': '/var/mail/cltbld', 12:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:58 INFO - 'MOZ_NO_REMOTE': '1', 12:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:58 INFO - 'NO_EM_RESTART': '1', 12:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:58 INFO - 'SHELL': '/bin/bash', 12:56:58 INFO - 'SHLVL': '1', 12:56:58 INFO - 'TERM': 'linux', 12:56:58 INFO - 'TMOUT': '86400', 12:56:58 INFO - 'USER': 'cltbld', 12:56:58 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:58 INFO - '_': '/tools/buildbot/bin/python'} 12:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:57:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:57:00 INFO - Installing collected packages: mozsystemmonitor 12:57:00 INFO - Running setup.py install for mozsystemmonitor 12:57:00 INFO - Successfully installed mozsystemmonitor 12:57:00 INFO - Cleaning up... 12:57:00 INFO - Return code: 0 12:57:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:00 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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:57:00 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 12:57:00 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 12:57:00 INFO - Using env: {'DISPLAY': ':0', 12:57:00 INFO - 'HOME': '/home/cltbld', 12:57:00 INFO - 'LANG': 'en_US.UTF-8', 12:57:00 INFO - 'LANGUAGE': 'en_US:en', 12:57:00 INFO - 'LOGNAME': 'cltbld', 12:57:00 INFO - 'MAIL': '/var/mail/cltbld', 12:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:00 INFO - 'MOZ_NO_REMOTE': '1', 12:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:00 INFO - 'NO_EM_RESTART': '1', 12:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:00 INFO - 'SHELL': '/bin/bash', 12:57:00 INFO - 'SHLVL': '1', 12:57:00 INFO - 'TERM': 'linux', 12:57:00 INFO - 'TMOUT': '86400', 12:57:00 INFO - 'USER': 'cltbld', 12:57:00 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:00 INFO - '_': '/tools/buildbot/bin/python'} 12:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:00 INFO - Downloading/unpacking blobuploader==1.2.4 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:02 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:57:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:02 INFO - Downloading docopt-0.6.1.tar.gz 12:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:02 INFO - Running setup.py install for blobuploader 12:57:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:57:02 INFO - Running setup.py install for requests 12:57:03 INFO - Running setup.py install for docopt 12:57:03 INFO - Successfully installed blobuploader requests docopt 12:57:03 INFO - Cleaning up... 12:57:03 INFO - Return code: 0 12:57:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:03 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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:57:03 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 12:57:03 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 12:57:03 INFO - Using env: {'DISPLAY': ':0', 12:57:03 INFO - 'HOME': '/home/cltbld', 12:57:03 INFO - 'LANG': 'en_US.UTF-8', 12:57:03 INFO - 'LANGUAGE': 'en_US:en', 12:57:03 INFO - 'LOGNAME': 'cltbld', 12:57:03 INFO - 'MAIL': '/var/mail/cltbld', 12:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:03 INFO - 'MOZ_NO_REMOTE': '1', 12:57:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:03 INFO - 'NO_EM_RESTART': '1', 12:57:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:03 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:03 INFO - 'SHELL': '/bin/bash', 12:57:03 INFO - 'SHLVL': '1', 12:57:03 INFO - 'TERM': 'linux', 12:57:03 INFO - 'TMOUT': '86400', 12:57:03 INFO - 'USER': 'cltbld', 12:57:03 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:03 INFO - '_': '/tools/buildbot/bin/python'} 12:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:03 INFO - Running setup.py (path:/tmp/pip-fseuJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:03 INFO - Running setup.py (path:/tmp/pip-2zjSaY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:03 INFO - Running setup.py (path:/tmp/pip-Aa7DuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:03 INFO - Running setup.py (path:/tmp/pip-tKPIo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:03 INFO - Running setup.py (path:/tmp/pip-M3_3LF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:04 INFO - Running setup.py (path:/tmp/pip-wDTi2y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:04 INFO - Running setup.py (path:/tmp/pip-6G_1Uo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:04 INFO - Running setup.py (path:/tmp/pip-Tx0mV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:04 INFO - Running setup.py (path:/tmp/pip-cdsrnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:04 INFO - Running setup.py (path:/tmp/pip-8SQkNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:04 INFO - Running setup.py (path:/tmp/pip-64guv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:04 INFO - Running setup.py (path:/tmp/pip-D_sqgq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:04 INFO - Running setup.py (path:/tmp/pip-gGd1ga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:04 INFO - Running setup.py (path:/tmp/pip-7OEqBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:04 INFO - Running setup.py (path:/tmp/pip-Ss8NUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:04 INFO - Running setup.py (path:/tmp/pip-Z2Ukpc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:04 INFO - Running setup.py (path:/tmp/pip-08a9xa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:04 INFO - Running setup.py install for manifestparser 12:57:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozcrash 12:57:05 INFO - Running setup.py install for mozdebug 12:57:05 INFO - Running setup.py install for mozdevice 12:57:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozfile 12:57:05 INFO - Running setup.py install for mozhttpd 12:57:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozinfo 12:57:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozInstall 12:57:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for mozleak 12:57:05 INFO - Running setup.py install for mozlog 12:57:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:57:05 INFO - Running setup.py install for moznetwork 12:57:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozprocess 12:57:06 INFO - Running setup.py install for mozprofile 12:57:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozrunner 12:57:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Running setup.py install for mozscreenshot 12:57:06 INFO - Running setup.py install for moztest 12:57:06 INFO - Running setup.py install for mozversion 12:57:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:57:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:06 INFO - Cleaning up... 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:57:06 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 12:57:06 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 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:06 INFO - Running setup.py (path:/tmp/pip-Q20vjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:06 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)) 12:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:06 INFO - Running setup.py (path:/tmp/pip-7AEjKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:07 INFO - Running setup.py (path:/tmp/pip-_PAHUq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:07 INFO - Running setup.py (path:/tmp/pip-lCibz2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:07 INFO - Running setup.py (path:/tmp/pip-iSf5kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:07 INFO - Running setup.py (path:/tmp/pip-HxytWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:07 INFO - Running setup.py (path:/tmp/pip-U3p1LG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:07 INFO - Running setup.py (path:/tmp/pip-jUxTxQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:07 INFO - Running setup.py (path:/tmp/pip-pgEML4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:07 INFO - Running setup.py (path:/tmp/pip-X6GSiD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:07 INFO - Running setup.py (path:/tmp/pip-ZZqOLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:07 INFO - Running setup.py (path:/tmp/pip-Z02JVk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:07 INFO - Running setup.py (path:/tmp/pip-LOmMUF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:07 INFO - Running setup.py (path:/tmp/pip-T9Rvd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:07 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)) 12:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:07 INFO - Running setup.py (path:/tmp/pip-vG31oZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:08 INFO - Running setup.py (path:/tmp/pip-yLbliD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:08 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)) 12:57:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:08 INFO - Running setup.py (path:/tmp/pip-61H9cV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 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)) 12:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:08 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)) 12:57:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:09 INFO - Downloading blessings-1.5.1.tar.gz 12:57:09 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 12:57:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:09 INFO - Installing collected packages: blessings 12:57:09 INFO - Running setup.py install for blessings 12:57:09 INFO - Successfully installed blessings 12:57:09 INFO - Cleaning up... 12:57:10 INFO - Return code: 0 12:57:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:57:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:10 INFO - Reading from file tmpfile_stdout 12:57:10 INFO - Current package versions: 12:57:10 INFO - argparse == 1.2.1 12:57:10 INFO - blessings == 1.5.1 12:57:10 INFO - blobuploader == 1.2.4 12:57:10 INFO - docopt == 0.6.1 12:57:10 INFO - manifestparser == 1.1 12:57:10 INFO - mozInstall == 1.12 12:57:10 INFO - mozcrash == 0.16 12:57:10 INFO - mozdebug == 0.1 12:57:10 INFO - mozdevice == 0.47 12:57:10 INFO - mozfile == 1.2 12:57:10 INFO - mozhttpd == 0.7 12:57:10 INFO - mozinfo == 0.9 12:57:10 INFO - mozleak == 0.1 12:57:10 INFO - mozlog == 3.0 12:57:10 INFO - moznetwork == 0.27 12:57:10 INFO - mozprocess == 0.22 12:57:10 INFO - mozprofile == 0.27 12:57:10 INFO - mozrunner == 6.11 12:57:10 INFO - mozscreenshot == 0.1 12:57:10 INFO - mozsystemmonitor == 0.0 12:57:10 INFO - moztest == 0.7 12:57:10 INFO - mozversion == 1.4 12:57:10 INFO - psutil == 3.1.1 12:57:10 INFO - requests == 1.2.3 12:57:10 INFO - wsgiref == 0.1.2 12:57:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:10 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')]} 12:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:10 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')]} 12:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:10 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 0x7f72799d4c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, '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': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', '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 12:57:10 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 12:57:10 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 12:57:10 INFO - Using env: {'DISPLAY': ':0', 12:57:10 INFO - 'HOME': '/home/cltbld', 12:57:10 INFO - 'LANG': 'en_US.UTF-8', 12:57:10 INFO - 'LANGUAGE': 'en_US:en', 12:57:10 INFO - 'LOGNAME': 'cltbld', 12:57:10 INFO - 'MAIL': '/var/mail/cltbld', 12:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:10 INFO - 'MOZ_NO_REMOTE': '1', 12:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:10 INFO - 'NO_EM_RESTART': '1', 12:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:10 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:10 INFO - 'SHELL': '/bin/bash', 12:57:10 INFO - 'SHLVL': '1', 12:57:10 INFO - 'TERM': 'linux', 12:57:10 INFO - 'TMOUT': '86400', 12:57:10 INFO - 'USER': 'cltbld', 12:57:10 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:10 INFO - '_': '/tools/buildbot/bin/python'} 12:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 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)) 12:57:10 INFO - Cleaning up... 12:57:10 INFO - Return code: 0 12:57:10 INFO - Running post-action listener: _resource_record_post_action 12:57:10 INFO - Running post-action listener: _start_resource_monitoring 12:57:10 INFO - Starting resource monitoring. 12:57:10 INFO - ##### 12:57:10 INFO - ##### Running install step. 12:57:10 INFO - ##### 12:57:10 INFO - Running pre-action listener: _resource_record_pre_action 12:57:10 INFO - Running main action method: install 12:57:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:10 INFO - Reading from file tmpfile_stdout 12:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:57:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:57:10 INFO - Reading from file tmpfile_stdout 12:57:10 INFO - Output received: 12:57:10 INFO - Usage: mozinstall [options] installer 12:57:10 INFO - Options: 12:57:10 INFO - -h, --help show this help message and exit 12:57:10 INFO - -d DEST, --destination=DEST 12:57:10 INFO - Directory to install application into. [default: 12:57:10 INFO - "/builds/slave/test-pgo"] 12:57:10 INFO - --app=APP Application being installed. [default: firefox] 12:57:10 INFO - mkdir: /builds/slave/test-pgo/build/application 12:57:10 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'] 12:57:10 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 12:57:25 INFO - Reading from file tmpfile_stdout 12:57:25 INFO - Output received: 12:57:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:57:25 INFO - Running post-action listener: _resource_record_post_action 12:57:25 INFO - ##### 12:57:25 INFO - ##### Running run-tests step. 12:57:25 INFO - ##### 12:57:25 INFO - Running pre-action listener: _resource_record_pre_action 12:57:25 INFO - Running main action method: run_tests 12:57:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:57:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:57:25 INFO - Python 2.7.3 12:57:25 INFO - Return code: 0 12:57:25 INFO - grabbing minidump binary from tooltool 12:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:25 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 0x23a78c0>, '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 0x2354420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23548b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:57:25 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 12:57:25 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 12:57:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:25 INFO - Return code: 0 12:57:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:57:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:57:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:57:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:57:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 12:57:25 INFO - Using env: {'DISPLAY': ':0', 12:57:25 INFO - 'HOME': '/home/cltbld', 12:57:25 INFO - 'LANG': 'en_US.UTF-8', 12:57:25 INFO - 'LANGUAGE': 'en_US:en', 12:57:25 INFO - 'LOGNAME': 'cltbld', 12:57:25 INFO - 'MAIL': '/var/mail/cltbld', 12:57:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:25 INFO - 'MOZ_NO_REMOTE': '1', 12:57:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:25 INFO - 'NO_EM_RESTART': '1', 12:57:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:25 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:57:25 INFO - 'SHELL': '/bin/bash', 12:57:25 INFO - 'SHLVL': '1', 12:57:25 INFO - 'TERM': 'linux', 12:57:25 INFO - 'TMOUT': '86400', 12:57:25 INFO - 'USER': 'cltbld', 12:57:25 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036', 12:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:25 INFO - '_': '/tools/buildbot/bin/python'} 12:57:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 12:57:25 INFO - mozversion INFO | application_buildid: 20151117113016 12:57:25 INFO - mozversion INFO | application_changeset: 3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726 12:57:25 INFO - mozversion INFO | application_display_name: Nightly 12:57:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:25 INFO - mozversion INFO | application_name: Firefox 12:57:25 INFO - mozversion INFO | application_remotingname: firefox 12:57:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:57:25 INFO - mozversion INFO | application_vendor: Mozilla 12:57:25 INFO - mozversion INFO | application_version: 45.0a1 12:57:25 INFO - mozversion INFO | platform_buildid: 20151117113016 12:57:25 INFO - mozversion INFO | platform_changeset: 3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726 12:57:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:57:25 INFO - mozversion INFO | platform_version: 45.0a1 12:57:25 INFO - 2015-11-17 12:57:25,444 DEBUG : using testdate: 1447793845 12:57:25 INFO - 2015-11-17 12:57:25,444 DEBUG : actual date: 1447793845 12:57:25 INFO - 2015-11-17 12:57:25,459 INFO : starting webserver on 'localhost:41282' 12:57:25 INFO - 2015-11-17 12:57:25,460 INFO : Starting test suite talos-linux64-ix-041 12:57:25 INFO - 2015-11-17 12:57:25,460 INFO : Starting test dromaeo_css 12:57:25 INFO - 2015-11-17 12:57:25,460 DEBUG : operating with platform_type : linux_ 12:57:25 INFO - 2015-11-17 12:57:25,461 INFO : Initialising browser for dromaeo_css test... 12:57:25 INFO - 2015-11-17 12:57:25,477 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPgqYUN/profile http://localhost:41282/getInfo.html 12:57:29 INFO - 2015-11-17 12:57:29,761 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:57:29 INFO - 2015-11-17 12:57:29,762 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:57:29 INFO - 2015-11-17 12:57:29,762 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:57:29 INFO - 2015-11-17 12:57:29,762 DEBUG : BROWSER_OUTPUT: __metrics 12:57:29 INFO - 2015-11-17 12:57:29,838 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:57:31 INFO - 2015-11-17 12:57:31,148 INFO : Browser initialized. 12:57:31 INFO - 2015-11-17 12:57:31,148 INFO : Running cycle 1/1 for dromaeo_css test... 12:57:31 INFO - 2015-11-17 12:57:31,149 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPgqYUN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:57:42 INFO - 2015-11-17 12:57:42,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 141246464 12:57:42 INFO - 2015-11-17 12:57:42,938 DEBUG : BROWSER_OUTPUT: 12:58:34 INFO - 2015-11-17 12:58:34,520 DEBUG : BROWSER_OUTPUT: 1447793914517 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:00:43 INFO - 2015-11-17 13:00:43,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41282/tests/dromaeo/cssquery-ext.html) 13:00:44 INFO - 2015-11-17 13:00:44,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 250355712 13:00:44 INFO - 2015-11-17 13:00:44,173 DEBUG : BROWSER_OUTPUT: 13:03:46 INFO - 2015-11-17 13:03:46,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-ext.html (next: http://localhost:41282/tests/dromaeo/cssquery-jquery.html) 13:03:47 INFO - 2015-11-17 13:03:47,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 217296896 13:03:47 INFO - 2015-11-17 13:03:47,271 DEBUG : BROWSER_OUTPUT: 13:06:49 INFO - 2015-11-17 13:06:49,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41282/tests/dromaeo/cssquery-mootools.html) 13:06:49 INFO - 2015-11-17 13:06:49,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 206110720 13:06:49 INFO - 2015-11-17 13:06:49,757 DEBUG : BROWSER_OUTPUT: 13:09:51 INFO - 2015-11-17 13:09:51,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41282/tests/dromaeo/cssquery-prototype.html) 13:09:52 INFO - 2015-11-17 13:09:52,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 202309632 13:09:52 INFO - 2015-11-17 13:09:52,141 DEBUG : BROWSER_OUTPUT: 13:12:54 INFO - 2015-11-17 13:12:54,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41282/tests/dromaeo/cssquery-yui.html) 13:12:55 INFO - 2015-11-17 13:12:55,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 204726272 13:12:55 INFO - 2015-11-17 13:12:55,073 DEBUG : BROWSER_OUTPUT: 13:15:57 INFO - 2015-11-17 13:15:57,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/dromaeo/cssquery-yui.html (next: http://localhost:41282/tests/dromaeo/cssquery-dojo.html) 13:15:58 INFO - 2015-11-17 13:15:58,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 267591680 13:15:58 INFO - 2015-11-17 13:15:58,016 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,018 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:15:58 INFO - 2015-11-17 13:15:58,018 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:15:58 INFO - 2015-11-17 13:15:58,018 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:15:58 INFO - 2015-11-17 13:15:58,018 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:15:58 INFO - 2015-11-17 13:15:58,019 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3147.8583463744135;3237.33634604906;3271.738260939125;3285.769996100274;3298.0270820108067;5168.250603662466;5270.762815673294;5438.075527160382;5478.096114141167;5494.203340515623;5412.621116521845;5474;5501.284832971718;5601.523870471005;5613.971930140354;4777.5222477752295;5039.042581909425;5066.695998240118;5102.36220472441;5154.768035438415;5140.1518749406305;5158.3552055993005;5210.062188806013;5212.426633070379;5212.921806172911;4856.15017371962;4939.58013568847;5005.299258103868;5008.398992120969;5051.368578927634;4939.431965323998;4940.876478088041;4943.802247910079;4953.678010929314;5020.824271150492;4910.926336104962;4927.211646136637;4933.703977761345;4936.160852655022;4999.725015124167;5213.6089793265655;5248.921266181011;5357.598180136505;5361;5459.781608735646;5888.705564721747;5999.910001349983;6007.309159446632;6012.639241645472;6019.729112189962;5986.102084687332;6001.399860014008;6007.669578173199;6010.669413182273;6012.368701286389;5327.121025030904;5444.50999410055;5539.446055394428;5635.239242702265;5652.434756524314;5918.201042859245;5938.732757025944;5942.821715348547;5957.970210148921;5984.491318237999;5731.598788084877;5779.595428319977;5786.363500014995;5790.218320526675;5823.359430462646;5761.308642962871;5843.152742852262;5866.120081987736;5872.265966754156;5876.794312199053;5816.505597024216;5822.155787410887;5822.417758224144;5823.88352232953;5827.096799996008;5830.941690583125;5834.504067154255;5835.620684655484;5836.795712150054;5838.32859221195;4396.802143903532;4447.132809102194;4465.843695470643;4477.686561940698;4542.818287268538;4042.2521833460905;4045.8381664733083;4047.4131250968444;4059.3099173140636;4079.9800049987502;5618.550515958796;5619;5619.522340601095;5620.409856965041;5621.80323688669;5750.626209296466;5823.126531020381;5869.090291004901;5904.468597826216;5917.792877249276;5565.860853478614;5570.136628822539;5572.192032155396;5575.776968921197;5603.7478313475995;5112.71880046601;5115.283860259567;5119.974400127976;5123.7438128093445;5135.97432012845;5905.379935106838;5992.670403127782;6056.121862329937;6098.878022439526;6099.085137229451;5967.940320596912;6003.879922401615;6076;6084.178635884099;6088.695565221633;6145.348866191089;6203.131561581473;6205.441510264098;6216.689165541795;6221.875562488815;5664.5751568631695;5769.8557536061935;5940.544765679217;5952.702364881652;6011.068284415923;5751.309842818889;5833;5838.065909454467;5839.854003649943;5870.119482077723;5772.018756811436;5777.480026797441;5801.1878337033695;5819;5819.621724587888;5647.519960803378;5661.065924122474;5791.305043394819;5797.246357973437;5798.797042103506;5714.142878568082;5715.428457154251;5721.199032135588;5723.8855222896145;5760.798372056958;5776.884462310646;5805.477507024219;5814.592978491465;5815.185873977562;5887.558433117448;5570.832875013756;5610.270664813548;5699.601027928005;5728.513076388387;5828.562857785599 13:15:58 INFO - 2015-11-17 13:15:58,021 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.3198158396502;579.9101139323406;585.7510558012846;601.1703848688809;607.656673979202;32091.518627220583;40104.598954010486;40876.591234087726;40890;40903.38644920329;44235;44424.33363499542;44723.55276447235;44965.55034449662;45021.32468012974;7593.506422082574;7725.072991241059;8733.257673097778;8888.733337999838;8913.509756963364;10560.894391056107;10816.67549973502;10818.35089894605;10848.837267440995;10874.836877446845;10524.263301568893;10602.257841951066;10620.150387968983;10627.946860265727;10628.574857005711;7899.131095579482;8019.438639295252;10499.055085042344;10673.946630266877;10997.670069897837;10472.581096756121;10609.363438193734;10613.204009699304;10620.097291730212;10623.043926046694;41191.588084119074;41512.58487415117;41540.1691966159;41710;41711.374329385086;3088.258817883714;3130.0296907958605;3203.5675183850117;3212.2932954749917;3419.863205471778;30304.02254370821;30554.84722576395;31096.844515777502;31311.217219569466;31845.840770795996;3525.4888041233876;3541.0347257272206;3541.38025845476;3637.5998640149564;3660.5790334111653;275168;277007;277936;277998;278006;58837.70581147067;59513;59519.404805952254;59555.10667339993;59692.104618430756;56133;56965.43034569684;63090.36909630937;68169.65915170491;69437.65281173562;15429.151396673291;15603.843961560466;15662.216889155497;15680.215989200495;15699.136547489998;11189.552417903356;11227.775444491064;11256.774864502828;11258.437078146224;11262.099032077414;19531.414057578295;19778;19779.20883164686;19793.703094453595;19812.108455119553;7588.8482230356185;7657.846843063107;7772.300492955661;7796.922030779733;7847.568383738949;852.4459101583896;862.1378621378622;988.4416893908823;995.6166875752742;1078.8273876179774;28711.71288287132;28875.133745987652;29518.55722164169;30135;31635.84182079075;990.2375171118342;994.2443742755557;995.5569771451635;1067.7330667333167;1079.6922876980022;15388.538343849703;15803.525894223192;15847.841521584867;15856.127912964666;16099.275532601061;330153;335762;336153;336261;336485.98654148023;53006.46993530093;53205.46794532005;53264;53324.20013699798;53335.19997200045;1255.7710064635162;1257.4341546304017;1260.9810852837215;1273.3124112979074;1429.7497937860833;26496.470070598865;29042.27394315159;29675.406491870475;29893.70106298909;30090.84954575213;43888.34167487426;44285.33571996358;44329.77835110933;44347;44392.334114988946;267906;269884;269937;270027;270451;27635.861820690767;28350.858245708638;31181;31620.683793161774;32219;38024;38307;38324.233515330096;38754.2249155021;39115;32733.836330819147;33145.668543314256;33264.537818469704;33480.832595836866;35680.183175271006;31731.20671983219;34397.82801085978;35789.64210357863;36438.63561364352;36895.44656830096;35188.64811351854;35699.286014280086;35925.64074359223;36111.819440902626;36369.45445818262;28008.29979250535;28597.28506787347;31880.68119318777;35038.47442288317;36383.81808090943;24644;25396.365090872878;25506.872465637553;25598.488030239663;25620 13:15:58 INFO - 2015-11-17 13:15:58,022 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.79315548315833;319.2274695237525;321.736176335405;322.3987263753101;323.640758757779;17028.829711702878;17437.651246975052;18201.544961375974;18886;18895.43313700591;10936.617218397358;11055.613053543128;11319.943400283008;11321.490532926018;11325.037371823384;4493.393391892102;4607.9308810367875;4629.814807407716;4635.6986795858165;4636.165490211777;4601.378813860137;4602;4605.148047611186;4607.769611519428;4611.838585649503;3355.8825441109566;3456.8444420001033;4431.623312018466;4542.682012259143;4568.657350698711;4809.975950120262;4874.610031197513;4907.214845624719;4917.680350777206;4922.433920099199;4107.342825147992;4185.874423767292;4291.785410729451;4293.720908140961;4296.720713153666;11370.147238957112;11859.703507412298;12722.554710585086;13328.067035307533;13645.113067650671;1816.2281030561958;1859.1169194632575;1892.6971684530547;1902.1037366654107;1957.0410498855601;10061;10175.236857235737;10181.185505159643;10199.18406527476;10209.2343074269;1695.5167777183567;1702.7616133741285;1711.6747817914681;1727.6285598596237;1794.3271273272524;56157.15764263539;56363.436365636226;56629.43370566324;57223.14165287524;59030.70484647549;6692.665366731644;6830.897536536956;7085.43316534676;7134.143902731706;7193;8462;8465.449745766506;8471.872921906177;8474.406791524658;8489.151084891462;5430.70131142791;5496.5053145217125;5570.108782594765;5612.887742245132;5618.4662457066515;5620.57845661577;5662.858428539237;5670.404607516234;5671.120976248688;5707.543396528268;3272.885449009273;3320.93358132836;3341.986691731569;3344.7324214062814;3356.5133055706788;1159.756451145269;1170.9121815863843;1173.8767429419788;1196.682879037056;1228.8832560906699;426.12218829211304;454.4319600499376;474.89789695215006;488.2675986020969;498.3770287141074;11259.380734059705;11710.88289117115;11815.11386646005;11967;12077;488.99511004889496;493.41283872191974;504.87630530520255;510.1378670047608;517.583345406951;5707.286589176353;6359;6559.672016399257;6949.652517374212;7088.0785497884945;542603;544043;544791;558882;576089;73449.26550734424;76561.61719191368;76911.61544192243;77001;77732.83400748993;560.9158626206101;568.7696482924422;569.33103603266;569.3736889421685;569.6126633888913;9651.758706032406;9764.414135151914;9832.754181145528;11431.02836258894;11468.541258349573;33872.830635846665;34146.658533414346;34518.48222276718;36180.4572931401;36901;47902.760486197345;47963.280550792464;48148.27777583409;48159.75920120377;48296.03407931892;14762.33569489397;15133;15155.621109472351;15354.539363819104;15441.305141268445;17179.05515196676;17460.95234285947;17507.56231094233;17835.821641783416;17874;14734.63163420923;14841.183734894685;15123.848761512245;15191.392344306105;15390.461333853262;9179.77050573741;9190.770230744285;9452.149306562442;9505.287103467406;14738.63153421173;9469.621215151317;9632.27757918173;9637.855432168382;9681.564329605044;9729.902700973184;12324.383780811102;12710.555130570385;13191.208527488381;14228.430862765788;14551.41794328215;9126.954365228397;9408.95295523518;9418.905810941802;9419.105185007413;11666.70833229176 13:15:58 INFO - 2015-11-17 13:15:58,025 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.1492674541785;1730.1435789284303;1774.7515347851304;1799.6130831871149;1800.6218694074244;6566.441852442542;7525.623718814065;7802.96098519508;7805.297523222909;7820.608969551528;7662.310392064713;7768.378529717623;7769.106552746436;7772.533647981125;7794.103678077023;1915.0999030455664;1939.5829896572234;2035.1452389996236;2057.0743165575477;2236.798688118069;2246.528229071897;2250.17868478006;2253.188852013274;2255.76314486979;2255.8533695309834;2162.935111946644;2235.966460503094;2236.183792915582;2236.821054315651;2237.641977283635;1939.1952339778975;1992.063730046883;2212.1814928476488;2263.5246598214394;2273.7385200701965;2251.819854411643;2259.762724913877;2284.4403121235405;2287.645414960684;2320.9767902320928;7799.181085985946;7862.01724784402;7863.606819659051;7866.488678235896;7882.842343153105;4602;4638.489766125724;4648.48866624671;4667.953320466786;4694.600958918496;2994.6556146043267;3036.5748795168693;3046.2116793051982;3058.632964044307;3104.2394613319657;956.8229877472689;974.4786539201493;983.6065573770477;990.267202270322;1039.6673064619324;10636.36181829085;10644.254902156852;10668.839967400496;10671;10694.091002264817;4072.3687828386646;4112;4123.773192474383;4238.660907127422;4247.214265360918;9167.724968250963;9171.220446262143;9189.3108016899;9242;9249.676261330957;4660.813567457264;4694.600958918462;4697.8590642280105;4702.811887524529;4707.270373092176;4224.556421575752;4241;4242.787860606957;4246.5116511600945;4250.277452833026;3579.302036102987;3625.510556074949;3628.600853906068;3653.1597732521136;3657.7256705747177;1136.5169802833764;1162.0471213604762;1163.4531770068054;1168.2348062019391;1169.818678104895;1321.3459337627935;1324.059917458596;1339.4776037345443;1355.8915286777035;1358.7825947848296;7376.114866216089;7617.923820761832;7740.26467485588;7787.06555213378;7793.688252469838;1033.075397519216;1054.8892366301582;1133.21241736992;1133.2916926920675;1154.1055681846635;5889.146073819272;5918.852028699317;5924;5935.703214839241;5935.821925342247;9328.207102396373;9350.719478415658;9520.000399958044;9715.36850104741;9716.514174291256;9465.763355916019;9543.761405964906;9600.951995239979;9628;9641.614335426504;7069.9646501767165;7183.748568800067;7193.89209161863;7214.494985350975;7223.92776072243;6909.516333856582;6927.134108236471;6947.062146610143;6949.722011119701;6952.130983627047;7799.103103143211;8105.797355066171;8107.3108785753875;8123.75628731139;8234.176582341717;8300.086990430927;8320.251177394064;8338.916610834056;8482.830343392974;8503.574821259035;6712.765053223114;6857.759978400732;7077.752278670222;7124;7129.893051604334;7596.392288617008;7651.120121186135;7657.425693072931;7667.69329226847;7667.846643067219;6204.875902481835;7011;7059.858802824017;7139.500234983501;7215.278472152742;6997.965010174917;7064.116985376828;7120.287971202838;7126;7160.033395491542;7140.892886606601;7196.604186769778;7199.640017999184;7207.8558428832175;7208.35124838767;6642.236142843635;6689.5986240825705;6691.1636045494315;6702.028205910213;6704.094947182068;6618.8345291368105;6686.364795344434;6701.32986701326;6701.631410272482;6713.6643167842385 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.2733385207797;300.4906683172023;304.5918469251203;305.95257735051064;308.1095633618841;5896.174535565019;5948.3456819749845;5978.671173085479;5986.401359864011;6045.516358691305;5706.457886500786;5777.0756678931375;5847.590668653196;5877.2947246330505;5926.407359264072;4529.524399937992;4533.77331133442;4544.068465964469;4553.635709143261;4558.749268790232;4345.826166953334;4547.931781023271;4551.180787458256;4551.772411379435;4552.044070745131;4382.671299652523;4394.47266328041;4492.550744925497;4499.167653984007;4510.774461276923;4490.999999999967;4493.910121797562;4494.955050449503;4496.437945256843;4499.370088187657;3901.902452438683;3902.863399780994;3903.2974064668347;3905.414187871842;3908.8241029153473;5528.06022976091;5628.183913332544;5630.549556035548;5635.80274690388;5641.435856414367;5207.297014902978;5212.061828870802;5212.218167274901;5214.687118772886;5216.26972223889;6265.624062556261;6271;6277.623342599459;6278.215223097113;6278.968605156945;4297.763623000734;4300.440942677463;4320.1575692739925;4321.503027151886;4323.200207961537;6362.904556431611;6528.216614006302;6544.280129185786;6551.93448065518;6554.672266386661;4388.780560972003;4389.341598760211;4400.867973960786;4403.515613282536;4405.9559404405545;4448.510663826976;4448.799804008828;4453.75504347264;4454.933176002362;4458.108378324348;5190.92213616796;5192.584593232532;5194.818181363634;5197.506236907488;5203.947960520346;6280.654563998933;6336.112944187817;6364.204474440695;6378.489720822323;6386.2975072741965;1554.968900622004;1573.5436723350101;1573.913434761099;1574.7874037004858;1577.7791109244715;1030.7114008077751;1038.4859494550246;1040.7918416316768;1049.7375656085978;1057.2018126314738;6132.08018797184;6143.508519318444;6147.569670123048;6148.354422785633;6154.630722156685;6546.738130474728;6547.508936829757;6556.475481961432;6559.770408035696;6560.376764207393;5991.281046274475;6020.939790602126;6120.081987701791;6123.663198524035;6132.448079672851;3528.8588456461453;3544.2734239480847;3563.0736008637423;3564.7326450516316;3574;6786.69459874297;6789.5586786859685;6793.558418702769;6796.626185559841;6813.182418109759;6635.402813746786;6778.661066946633;6779.694913728894;6788.185417749803;6802.65986700663;6776.69504872282;6796.558223715443;6798.082258895085;6803.693833777492;6806.285340039224;6600.702968366339;6601.867962640624;6608.801735947929;6609.173853268341;6611.537192396486;6394.200724909387;6527.379898909596;6531.412172904272;6532.379423954717;6551.508636852351;6770.593764374154;6770.830729231809;6772.356626120511;6776.119104516381;6783.287754785873;4440.356148358405;4443.466783985942;4443.6667249955735;4446;4459.754713490789;6455.999320105391;6591.967040164768;6597.670116494252;6598.307177746459;6598.901016484852;6410.839729006812;6425.742970281136;6426.4216220540375;6429.678516074271;6432.839179020562;6407.199100112486;6410.775622853178;6416.807495775134;6420.582662126947;6423.710933007932;6191.102290167991;6309;6311.337309582611;6317.052442133717;6317.905231421624;6390.7763228286785;6398.616083035033;6406.391392817675;6407.807765767035;6409.615423074444;6234.438900498977;6255.030470277115;6265.122882796321;6291;6295.653739044396 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: |5;yui.html;752.8193233623932;777.3314949143736;841.7643059943218;868.5148396242429;873.2097451806115;14140.717185656293;14580.270986450661;14589.854101458983;14615.634609134777;14622.853771462282;13390.66523336917;13510.729785404286;13518.256495892721;13528.93235533821;13529.391177397016;678.2234341678775;689.176434161175;823.9876401853977;828.6975254032295;843.9324854011695;827.764087235138;830.9127541608104;834.0533494483774;838.8154605986704;839.6851180807197;857.8112815180682;871.1375738019346;871.1636828644508;871.3290766110091;871.9433236839585;708.1219288082792;717.8671945690064;857.0401150711212;877.9956100219522;878.2710350409145;623.4233334165879;630.492453574872;635.8696467224208;636.9745210191587;638.7349250061219;13366.46534138643;13378.799318010238;13428.664283392896;13491.595252142451;13515.391807368595;11275.548978040868;11346.149038822039;12764.425600847984;12997.545085922042;13061.804072938914;10535.947320263427;10633.5214915329;10752.086072683831;10763.892361076445;10879.619213327496;3638.9272214555563;3698.33429982603;3706.499622550948;3744.1762812181278;3818.6754125899333;43028.92427689301;43577.78211108924;43923.34114988278;44860.55139448596;49296.75351623219;10421.791564168674;10643.733906652396;10648;10651.786964260671;10814.29707069038;19123.90438047801;19274.518137046685;19293.421197364103;19303;19344.032798360025;7745.690172393154;7888.605569721606;7895.131535531087;7924.524528528192;8014.8069489447325;3980.434814928622;4024.879253622396;4044.939325910114;4076.8165432555606;4095.5699651536756;3116.703913128249;3132.561441398206;3134.952975705366;3138.4037032963665;3148.449021421242;483.1134420089556;487.40779952358054;487.4516169309527;489.8089744999453;490.673701988181;674.3930462583616;684.1824020295799;694.1947341084318;694.8645014222178;729.5075823818901;8691.348148888732;9159.404638698463;9456.763580910532;9891.505424728735;10065.547274849583;697.6442014572605;707.9964600177069;722.6675729164643;729.3836707981746;731.4294850016995;4154.50145982478;4354.303311470149;4466.503721253352;4527.139843429738;4546.840860569864;59922.70038649779;63143.684281578295;63346;63407.04889426662;63493.36506634967;50384;50762.74618626883;51191.23213151806;51196.488035119175;52127.47872521302;46295.76852115718;46296.76851615653;46326.305105423446;46666.5333346669;46745;9005.099490050943;9066.410683305565;9193.540322983958;9301.441913485212;9529.380590261611;35988.64011359853;36279.455808163424;36638.450423244205;37419.81290093532;37537.2492550142;45863.54136458593;45876.31185532286;46499.30251046169;46870;47255.763721181174;7627.809304767426;7776.766696999099;8231.794205144679;8295.83408331818;8423.326133909395;12499.500019999097;12572.685682858002;12712.427940742504;12755.61733148007;12793.104482686123;11025.283356581796;11414.315141091562;11416.486258118572;11849.466773995018;12321.014318854292;12202.206856554296;12271.325077120844;12442.129050966345;12622.431990560262;12725.61823145307;11593.768124637292;11788.528458861549;11818.704532386415;12184.634460966185;12245.448954796877;9899.50502474859;10119.59521619127;10151.64469243573;10723.463826808784;10751.516181771996;9831.754206144904;10265.2301077418;10269.589216431259;10329.173666106542;10352 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 13:15:58 INFO - 2015-11-17 13:15:58,026 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:15:58 INFO - 2015-11-17 13:15:58,027 DEBUG : BROWSER_OUTPUT: __startTimestamp1447794958017__endTimestamp 13:15:58 INFO - 2015-11-17 13:15:58,027 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,027 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:15:58 INFO - 2015-11-17 13:15:58,027 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5476.62 Median:5715.43 stddev:620.35 (10.9%) stddev-sans-first:594.74 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: Values: 3147.9 3237.3 3271.7 3285.8 3298.0 5168.3 5270.8 5438.1 5478.1 5494.2 5412.6 5474.0 5501.3 5601.5 5614.0 4777.5 5039.0 5066.7 5102.4 5154.8 5140.2 5158.4 5210.1 5212.4 5212.9 4856.2 4939.6 5005.3 5008.4 5051.4 4939.4 4940.9 4943.8 4953.7 5020.8 4910.9 4927.2 4933.7 4936.2 4999.7 5213.6 5248.9 5357.6 5361.0 5459.8 5888.7 5999.9 6007.3 6012.6 6019.7 5986.1 6001.4 6007.7 6010.7 6012.4 5327.1 5444.5 5539.4 5635.2 5652.4 5918.2 5938.7 5942.8 5958.0 5984.5 5731.6 5779.6 5786.4 5790.2 5823.4 5761.3 5843.2 5866.1 5872.3 5876.8 5816.5 5822.2 5822.4 5823.9 5827.1 5830.9 5834.5 5835.6 5836.8 5838.3 4396.8 4447.1 4465.8 4477.7 4542.8 4042.3 4045.8 4047.4 4059.3 4080.0 5618.6 5619.0 5619.5 5620.4 5621.8 5750.6 5823.1 5869.1 5904.5 5917.8 5565.9 5570.1 5572.2 5575.8 5603.7 5112.7 5115.3 5120.0 5123.7 5136.0 5905.4 5992.7 6056.1 6098.9 6099.1 5967.9 6003.9 6076.0 6084.2 6088.7 6145.3 6203.1 6205.4 6216.7 6221.9 5664.6 5769.9 5940.5 5952.7 6011.1 5751.3 5833.0 5838.1 5839.9 5870.1 5772.0 5777.5 5801.2 5819.0 5819.6 5647.5 5661.1 5791.3 5797.2 5798.8 5714.1 5715.4 5721.2 5723.9 5760.8 5776.9 5805.5 5814.6 5815.2 5887.6 5570.8 5610.3 5699.6 5728.5 5828.6 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46607.00 Median:181443.42 stddev:77158.90 (42.5%) stddev-sans-first:77297.83 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: Values: 541.3 579.9 585.8 601.2 607.7 32091.5 40104.6 40876.6 40890.0 40903.4 44235.0 44424.3 44723.6 44965.6 45021.3 7593.5 7725.1 8733.3 8888.7 8913.5 10560.9 10816.7 10818.4 10848.8 10874.8 10524.3 10602.3 10620.2 10627.9 10628.6 7899.1 8019.4 10499.1 10673.9 10997.7 10472.6 10609.4 10613.2 10620.1 10623.0 41191.6 41512.6 41540.2 41710.0 41711.4 3088.3 3130.0 3203.6 3212.3 3419.9 30304.0 30554.8 31096.8 31311.2 31845.8 3525.5 3541.0 3541.4 3637.6 3660.6 275168.0 277007.0 277936.0 277998.0 278006.0 58837.7 59513.0 59519.4 59555.1 59692.1 56133.0 56965.4 63090.4 68169.7 69437.7 15429.2 15603.8 15662.2 15680.2 15699.1 11189.6 11227.8 11256.8 11258.4 11262.1 19531.4 19778.0 19779.2 19793.7 19812.1 7588.8 7657.8 7772.3 7796.9 7847.6 852.4 862.1 988.4 995.6 1078.8 28711.7 28875.1 29518.6 30135.0 31635.8 990.2 994.2 995.6 1067.7 1079.7 15388.5 15803.5 15847.8 15856.1 16099.3 330153.0 335762.0 336153.0 336261.0 336486.0 53006.5 53205.5 53264.0 53324.2 53335.2 1255.8 1257.4 1261.0 1273.3 1429.7 26496.5 29042.3 29675.4 29893.7 30090.8 43888.3 44285.3 44329.8 44347.0 44392.3 267906.0 269884.0 269937.0 270027.0 270451.0 27635.9 28350.9 31181.0 31620.7 32219.0 38024.0 38307.0 38324.2 38754.2 39115.0 32733.8 33145.7 33264.5 33480.8 35680.2 31731.2 34397.8 35789.6 36438.6 36895.4 35188.6 35699.3 35925.6 36111.8 36369.5 28008.3 28597.3 31880.7 35038.5 36383.8 24644.0 25396.4 25506.9 25598.5 25620.0 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,028 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27799.38 Median:4555.67 stddev:90569.32 (1988.1%) stddev-sans-first:90799.87 13:15:58 INFO - 2015-11-17 13:15:58,029 DEBUG : BROWSER_OUTPUT: Values: 315.8 319.2 321.7 322.4 323.6 17028.8 17437.7 18201.5 18886.0 18895.4 10936.6 11055.6 11319.9 11321.5 11325.0 4493.4 4607.9 4629.8 4635.7 4636.2 4601.4 4602.0 4605.1 4607.8 4611.8 3355.9 3456.8 4431.6 4542.7 4568.7 4810.0 4874.6 4907.2 4917.7 4922.4 4107.3 4185.9 4291.8 4293.7 4296.7 11370.1 11859.7 12722.6 13328.1 13645.1 1816.2 1859.1 1892.7 1902.1 1957.0 10061.0 10175.2 10181.2 10199.2 10209.2 1695.5 1702.8 1711.7 1727.6 1794.3 56157.2 56363.4 56629.4 57223.1 59030.7 6692.7 6830.9 7085.4 7134.1 7193.0 8462.0 8465.4 8471.9 8474.4 8489.2 5430.7 5496.5 5570.1 5612.9 5618.5 5620.6 5662.9 5670.4 5671.1 5707.5 3272.9 3320.9 3342.0 3344.7 3356.5 1159.8 1170.9 1173.9 1196.7 1228.9 426.1 454.4 474.9 488.3 498.4 11259.4 11710.9 11815.1 11967.0 12077.0 489.0 493.4 504.9 510.1 517.6 5707.3 6359.0 6559.7 6949.7 7088.1 542603.0 544043.0 544791.0 558882.0 576089.0 73449.3 76561.6 76911.6 77001.0 77732.8 560.9 568.8 569.3 569.4 569.6 9651.8 9764.4 9832.8 11431.0 11468.5 33872.8 34146.7 34518.5 36180.5 36901.0 47902.8 47963.3 48148.3 48159.8 48296.0 14762.3 15133.0 15155.6 15354.5 15441.3 17179.1 17461.0 17507.6 17835.8 17874.0 14734.6 14841.2 15123.8 15191.4 15390.5 9179.8 9190.8 9452.1 9505.3 14738.6 9469.6 9632.3 9637.9 9681.6 9729.9 12324.4 12710.6 13191.2 14228.4 14551.4 9127.0 9409.0 9418.9 9419.1 11666.7 13:15:58 INFO - 2015-11-17 13:15:58,029 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,030 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5474.60 Median:6687.98 stddev:2844.59 (42.5%) stddev-sans-first:2835.86 13:15:58 INFO - 2015-11-17 13:15:58,030 DEBUG : BROWSER_OUTPUT: Values: 1372.1 1730.1 1774.8 1799.6 1800.6 6566.4 7525.6 7803.0 7805.3 7820.6 7662.3 7768.4 7769.1 7772.5 7794.1 1915.1 1939.6 2035.1 2057.1 2236.8 2246.5 2250.2 2253.2 2255.8 2255.9 2162.9 2236.0 2236.2 2236.8 2237.6 1939.2 1992.1 2212.2 2263.5 2273.7 2251.8 2259.8 2284.4 2287.6 2321.0 7799.2 7862.0 7863.6 7866.5 7882.8 4602.0 4638.5 4648.5 4668.0 4694.6 2994.7 3036.6 3046.2 3058.6 3104.2 956.8 974.5 983.6 990.3 1039.7 10636.4 10644.3 10668.8 10671.0 10694.1 4072.4 4112.0 4123.8 4238.7 4247.2 9167.7 9171.2 9189.3 9242.0 9249.7 4660.8 4694.6 4697.9 4702.8 4707.3 4224.6 4241.0 4242.8 4246.5 4250.3 3579.3 3625.5 3628.6 3653.2 3657.7 1136.5 1162.0 1163.5 1168.2 1169.8 1321.3 1324.1 1339.5 1355.9 1358.8 7376.1 7617.9 7740.3 7787.1 7793.7 1033.1 1054.9 1133.2 1133.3 1154.1 5889.1 5918.9 5924.0 5935.7 5935.8 9328.2 9350.7 9520.0 9715.4 9716.5 9465.8 9543.8 9601.0 9628.0 9641.6 7070.0 7183.7 7193.9 7214.5 7223.9 6909.5 6927.1 6947.1 6949.7 6952.1 7799.1 8105.8 8107.3 8123.8 8234.2 8300.1 8320.3 8338.9 8482.8 8503.6 6712.8 6857.8 7077.8 7124.0 7129.9 7596.4 7651.1 7657.4 7667.7 7667.8 6204.9 7011.0 7059.9 7139.5 7215.3 6998.0 7064.1 7120.3 7126.0 7160.0 7140.9 7196.6 7199.6 7207.9 7208.4 6642.2 6689.6 6691.2 6702.0 6704.1 6618.8 6686.4 6701.3 6701.6 6713.7 13:15:58 INFO - 2015-11-17 13:15:58,030 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,030 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5286.88 Median:6033.23 stddev:1622.51 (26.9%) stddev-sans-first:1583.30 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: Values: 300.3 300.5 304.6 306.0 308.1 5896.2 5948.3 5978.7 5986.4 6045.5 5706.5 5777.1 5847.6 5877.3 5926.4 4529.5 4533.8 4544.1 4553.6 4558.7 4345.8 4547.9 4551.2 4551.8 4552.0 4382.7 4394.5 4492.6 4499.2 4510.8 4491.0 4493.9 4495.0 4496.4 4499.4 3901.9 3902.9 3903.3 3905.4 3908.8 5528.1 5628.2 5630.5 5635.8 5641.4 5207.3 5212.1 5212.2 5214.7 5216.3 6265.6 6271.0 6277.6 6278.2 6279.0 4297.8 4300.4 4320.2 4321.5 4323.2 6362.9 6528.2 6544.3 6551.9 6554.7 4388.8 4389.3 4400.9 4403.5 4406.0 4448.5 4448.8 4453.8 4454.9 4458.1 5190.9 5192.6 5194.8 5197.5 5203.9 6280.7 6336.1 6364.2 6378.5 6386.3 1555.0 1573.5 1573.9 1574.8 1577.8 1030.7 1038.5 1040.8 1049.7 1057.2 6132.1 6143.5 6147.6 6148.4 6154.6 6546.7 6547.5 6556.5 6559.8 6560.4 5991.3 6020.9 6120.1 6123.7 6132.4 3528.9 3544.3 3563.1 3564.7 3574.0 6786.7 6789.6 6793.6 6796.6 6813.2 6635.4 6778.7 6779.7 6788.2 6802.7 6776.7 6796.6 6798.1 6803.7 6806.3 6600.7 6601.9 6608.8 6609.2 6611.5 6394.2 6527.4 6531.4 6532.4 6551.5 6770.6 6770.8 6772.4 6776.1 6783.3 4440.4 4443.5 4443.7 4446.0 4459.8 6456.0 6592.0 6597.7 6598.3 6598.9 6410.8 6425.7 6426.4 6429.7 6432.8 6407.2 6410.8 6416.8 6420.6 6423.7 6191.1 6309.0 6311.3 6317.1 6317.9 6390.8 6398.6 6406.4 6407.8 6409.6 6234.4 6255.0 6265.1 6291.0 6295.7 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14126.90 Median:24693.85 stddev:16332.56 (66.1%) stddev-sans-first:16347.50 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: Values: 752.8 777.3 841.8 868.5 873.2 14140.7 14580.3 14589.9 14615.6 14622.9 13390.7 13510.7 13518.3 13528.9 13529.4 678.2 689.2 824.0 828.7 843.9 827.8 830.9 834.1 838.8 839.7 857.8 871.1 871.2 871.3 871.9 708.1 717.9 857.0 878.0 878.3 623.4 630.5 635.9 637.0 638.7 13366.5 13378.8 13428.7 13491.6 13515.4 11275.5 11346.1 12764.4 12997.5 13061.8 10535.9 10633.5 10752.1 10763.9 10879.6 3638.9 3698.3 3706.5 3744.2 3818.7 43028.9 43577.8 43923.3 44860.6 49296.8 10421.8 10643.7 10648.0 10651.8 10814.3 19123.9 19274.5 19293.4 19303.0 19344.0 7745.7 7888.6 7895.1 7924.5 8014.8 3980.4 4024.9 4044.9 4076.8 4095.6 3116.7 3132.6 3135.0 3138.4 3148.4 483.1 487.4 487.5 489.8 490.7 674.4 684.2 694.2 694.9 729.5 8691.3 9159.4 9456.8 9891.5 10065.5 697.6 708.0 722.7 729.4 731.4 4154.5 4354.3 4466.5 4527.1 4546.8 59922.7 63143.7 63346.0 63407.0 63493.4 50384.0 50762.7 51191.2 51196.5 52127.5 46295.8 46296.8 46326.3 46666.5 46745.0 9005.1 9066.4 9193.5 9301.4 9529.4 35988.6 36279.5 36638.5 37419.8 37537.2 45863.5 45876.3 46499.3 46870.0 47255.8 7627.8 7776.8 8231.8 8295.8 8423.3 12499.5 12572.7 12712.4 12755.6 12793.1 11025.3 11414.3 11416.5 11849.5 12321.0 12202.2 12271.3 12442.1 12622.4 12725.6 11593.8 11788.5 11818.7 12184.6 12245.4 9899.5 10119.6 10151.6 10723.5 10751.5 9831.8 10265.2 10269.6 10329.2 10352.0 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:15:58 INFO - 2015-11-17 13:15:58,031 DEBUG : BROWSER_OUTPUT: 13:15:58 INFO - 2015-11-17 13:15:58,727 INFO : Browser exited with error code: 0 13:15:58 INFO - 2015-11-17 13:15:58,751 INFO : Completed test dromaeo_css (00:18:33) 13:15:58 INFO - 2015-11-17 13:15:58,751 INFO : Starting test kraken 13:15:58 INFO - 2015-11-17 13:15:58,751 DEBUG : operating with platform_type : linux_ 13:15:58 INFO - 2015-11-17 13:15:58,751 INFO : Initialising browser for kraken test... 13:15:58 INFO - 2015-11-17 13:15:58,757 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGR1Em8/profile http://localhost:41282/getInfo.html 13:16:02 INFO - 2015-11-17 13:16:02,896 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:16:02 INFO - 2015-11-17 13:16:02,897 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:16:02 INFO - 2015-11-17 13:16:02,897 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:16:02 INFO - 2015-11-17 13:16:02,897 DEBUG : BROWSER_OUTPUT: __metrics 13:16:03 INFO - 2015-11-17 13:16:03,005 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:04 INFO - 2015-11-17 13:16:04,479 INFO : Browser initialized. 13:16:04 INFO - 2015-11-17 13:16:04,479 INFO : Running cycle 1/1 for kraken test... 13:16:04 INFO - 2015-11-17 13:16:04,479 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGR1Em8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:16:16 INFO - 2015-11-17 13:16:16,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 141737984 13:16:16 INFO - 2015-11-17 13:16:16,251 DEBUG : BROWSER_OUTPUT: 13:16:18 INFO - 2015-11-17 13:16:18,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:19 INFO - 2015-11-17 13:16:19,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 180203520 13:16:19 INFO - 2015-11-17 13:16:19,287 DEBUG : BROWSER_OUTPUT: 13:16:21 INFO - 2015-11-17 13:16:21,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-dft) 13:16:22 INFO - 2015-11-17 13:16:22,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 168574976 13:16:22 INFO - 2015-11-17 13:16:22,461 DEBUG : BROWSER_OUTPUT: 13:16:25 INFO - 2015-11-17 13:16:25,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-fft) 13:16:25 INFO - 2015-11-17 13:16:25,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 150290432 13:16:25 INFO - 2015-11-17 13:16:25,901 DEBUG : BROWSER_OUTPUT: 13:16:27 INFO - 2015-11-17 13:16:27,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41282/tests/kraken/driver.html?testName=audio-oscillator) 13:16:28 INFO - 2015-11-17 13:16:28,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 154062848 13:16:28 INFO - 2015-11-17 13:16:28,441 DEBUG : BROWSER_OUTPUT: 13:16:30 INFO - 2015-11-17 13:16:30,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:31 INFO - 2015-11-17 13:16:31,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 156278784 13:16:31 INFO - 2015-11-17 13:16:31,140 DEBUG : BROWSER_OUTPUT: 13:16:34 INFO - 2015-11-17 13:16:34,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:34 INFO - 2015-11-17 13:16:34,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 154206208 13:16:34 INFO - 2015-11-17 13:16:34,606 DEBUG : BROWSER_OUTPUT: 13:16:37 INFO - 2015-11-17 13:16:37,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41282/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:38 INFO - 2015-11-17 13:16:38,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 156467200 13:16:38 INFO - 2015-11-17 13:16:38,554 DEBUG : BROWSER_OUTPUT: 13:16:41 INFO - 2015-11-17 13:16:41,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41282/tests/kraken/driver.html?testName=json-parse-financial) 13:16:41 INFO - 2015-11-17 13:16:41,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 156856320 13:16:41 INFO - 2015-11-17 13:16:41,931 DEBUG : BROWSER_OUTPUT: 13:16:43 INFO - 2015-11-17 13:16:43,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:44 INFO - 2015-11-17 13:16:44,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 165384192 13:16:44 INFO - 2015-11-17 13:16:44,041 DEBUG : BROWSER_OUTPUT: 13:16:45 INFO - 2015-11-17 13:16:45,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:46 INFO - 2015-11-17 13:16:46,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 164036608 13:16:46 INFO - 2015-11-17 13:16:46,500 DEBUG : BROWSER_OUTPUT: 13:16:48 INFO - 2015-11-17 13:16:48,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:49 INFO - 2015-11-17 13:16:49,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 168820736 13:16:49 INFO - 2015-11-17 13:16:49,106 DEBUG : BROWSER_OUTPUT: 13:16:51 INFO - 2015-11-17 13:16:51,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:52 INFO - 2015-11-17 13:16:52,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 178339840 13:16:52 INFO - 2015-11-17 13:16:52,087 DEBUG : BROWSER_OUTPUT: 13:16:54 INFO - 2015-11-17 13:16:54,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:55 INFO - 2015-11-17 13:16:55,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 178384896 13:16:55 INFO - 2015-11-17 13:16:55,183 DEBUG : BROWSER_OUTPUT: 13:16:56 INFO - 2015-11-17 13:16:56,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41282/tests/kraken/driver.html?testName=ai-astar) 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 238133248 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:16:57 INFO - 2015-11-17 13:16:57,075 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;104;110;109;110;97;108;110;108 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;124;162;162;127;151;148;142;169;131 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;163;160;159;162;161;164;161;163 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;83;91;72;72;72;97;92;72 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;135;91;90;90;133;90;91;133 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;111;110;110;111 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;146;145;145;145;144;145;145 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;96 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;56;57;58;57;60;64;56;55 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;82;69;69;69 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;85;84;86;84;91;84;84 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;117;117;123;124;114;125;119;123;127 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;150;150;149;152;142;151;142;151;140 13:16:57 INFO - 2015-11-17 13:16:57,076 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;66;68;67;68;68;65;68 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: __startTimestamp1447795017069__endTimestamp 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,077 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:109.50 stddev:4.02 (3.7%) stddev-sans-first:4.27 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 104.0 110.0 109.0 110.0 97.0 108.0 110.0 108.0 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:150.00 stddev:15.50 (10.3%) stddev-sans-first:16.41 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: Values: 149.0 124.0 162.0 162.0 127.0 151.0 148.0 142.0 169.0 131.0 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 163.0 160.0 159.0 162.0 161.0 164.0 161.0 163.0 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,078 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.30 Median:77.50 stddev:10.41 (13.4%) stddev-sans-first:10.60 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 83.0 91.0 72.0 72.0 72.0 97.0 92.0 72.0 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:90.00 stddev:20.90 (23.2%) stddev-sans-first:21.60 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 135.0 91.0 90.0 90.0 133.0 90.0 91.0 133.0 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 111.0 110.0 110.0 111.0 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 144.0 145.0 145.0 13:16:57 INFO - 2015-11-17 13:16:57,079 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:2.57 (4.5%) stddev-sans-first:2.73 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 56.0 57.0 58.0 57.0 60.0 64.0 56.0 55.0 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:69.00 stddev:4.20 (6.1%) stddev-sans-first:4.39 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 82.0 69.0 69.0 69.0 13:16:57 INFO - 2015-11-17 13:16:57,080 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,081 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.28 (2.7%) stddev-sans-first:2.40 13:16:57 INFO - 2015-11-17 13:16:57,081 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 85.0 84.0 86.0 84.0 91.0 84.0 84.0 13:16:57 INFO - 2015-11-17 13:16:57,081 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,081 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:123.00 stddev:4.15 (3.4%) stddev-sans-first:4.39 13:16:57 INFO - 2015-11-17 13:16:57,082 DEBUG : BROWSER_OUTPUT: Values: 120.0 117.0 117.0 123.0 124.0 114.0 125.0 119.0 123.0 127.0 13:16:57 INFO - 2015-11-17 13:16:57,082 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,082 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:150.00 stddev:4.87 (3.2%) stddev-sans-first:4.69 13:16:57 INFO - 2015-11-17 13:16:57,082 DEBUG : BROWSER_OUTPUT: Values: 141.0 150.0 150.0 149.0 152.0 142.0 151.0 142.0 151.0 140.0 13:16:57 INFO - 2015-11-17 13:16:57,082 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,083 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 13:16:57 INFO - 2015-11-17 13:16:57,083 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 66.0 68.0 67.0 68.0 68.0 65.0 68.0 13:16:57 INFO - 2015-11-17 13:16:57,083 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:16:57 INFO - 2015-11-17 13:16:57,083 DEBUG : BROWSER_OUTPUT: 13:16:57 INFO - 2015-11-17 13:16:57,923 INFO : Browser exited with error code: 0 13:16:57 INFO - 2015-11-17 13:16:57,977 INFO : Completed test kraken (00:00:59) 13:16:57 INFO - 2015-11-17 13:16:57,977 INFO : Starting test v8_7 13:16:57 INFO - 2015-11-17 13:16:57,977 DEBUG : operating with platform_type : linux_ 13:16:57 INFO - 2015-11-17 13:16:57,977 INFO : Initialising browser for v8_7 test... 13:16:57 INFO - 2015-11-17 13:16:57,983 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyO7RDw/profile http://localhost:41282/getInfo.html 13:17:01 INFO - 2015-11-17 13:17:01,890 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:17:01 INFO - 2015-11-17 13:17:01,890 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:17:01 INFO - 2015-11-17 13:17:01,891 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:17:01 INFO - 2015-11-17 13:17:01,891 DEBUG : BROWSER_OUTPUT: __metrics 13:17:02 INFO - 2015-11-17 13:17:02,068 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:03 INFO - 2015-11-17 13:17:03,303 INFO : Browser initialized. 13:17:03 INFO - 2015-11-17 13:17:03,303 INFO : Running cycle 1/1 for v8_7 test... 13:17:03 INFO - 2015-11-17 13:17:03,303 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyO7RDw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:17:15 INFO - 2015-11-17 13:17:15,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 13:17:15 INFO - 2015-11-17 13:17:15,022 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41282/tests/v8_7/run.html (next: http://localhost:41282/tests/v8_7/run.html) 13:17:36 INFO - 2015-11-17 13:17:36,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 612528128 13:17:36 INFO - 2015-11-17 13:17:36,748 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,748 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:17:36 INFO - 2015-11-17 13:17:36,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:17:36 INFO - 2015-11-17 13:17:36,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |0;Richards;162.60162601626016 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.040616773223 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.06271379703537 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1104.9723756906078 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |5;Earley;778.816199376947 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |8;Splay;664.0368178829717 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: __startTimestamp1447795056742__endTimestamp 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:17:36 INFO - 2015-11-17 13:17:36,749 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.60 Median:162.60 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: Values: 162.6 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: Values: 188.0 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: Values: 285.1 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: Values: 5020.0 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1104.97 Median:1104.97 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: Values: 1105.0 13:17:36 INFO - 2015-11-17 13:17:36,750 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: Values: 778.8 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: Values: 12144.6 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: Values: 25717.9 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:664.04 Median:664.04 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: Values: 664.0 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: Values: 4835.7 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:17:36 INFO - 2015-11-17 13:17:36,751 DEBUG : BROWSER_OUTPUT: 13:17:37 INFO - 2015-11-17 13:17:37,643 INFO : Browser exited with error code: 0 13:17:37 INFO - 2015-11-17 13:17:37,660 INFO : Completed test v8_7 (00:00:39) 13:17:37 INFO - 2015-11-17 13:17:37,686 INFO : Completed test suite (00:20:12) 13:17:37 INFO - 2015-11-17 13:17:37,686 DEBUG : Working with test: dromaeo_css 13:17:37 INFO - 2015-11-17 13:17:37,686 DEBUG : Generating results file: dromaeo_css 13:17:37 INFO - 2015-11-17 13:17:37,688 DEBUG : Working with test: kraken 13:17:37 INFO - 2015-11-17 13:17:37,688 DEBUG : Generating results file: kraken 13:17:37 INFO - 2015-11-17 13:17:37,688 INFO : javascript benchmark 13:17:37 INFO - 2015-11-17 13:17:37,688 DEBUG : Working with test: v8_7 13:17:37 INFO - 2015-11-17 13:17:37,688 DEBUG : Generating results file: v8_7 13:17:37 INFO - 2015-11-17 13:17:37,689 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:37 INFO - 2015-11-17 13:17:37,750 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 13:17:37 INFO - 2015-11-17 13:17:37,750 DEBUG : process_Request line: dromaeo_css 6821.40 graph.html#tests=[[72,64,35]] 13:17:37 INFO - 2015-11-17 13:17:37,750 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:37 INFO - 2015-11-17 13:17:37,794 DEBUG : process_Request line: kraken 1496.60 graph.html#tests=[[232,64,35]] 13:17:37 INFO - 2015-11-17 13:17:37,794 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:37 INFO - 2015-11-17 13:17:37,823 DEBUG : process_Request line: v8_7 20976.85 graph.html#tests=[[230,64,35]] 13:17:37 INFO - 2015-11-17 13:17:37,824 INFO : javascript benchmark 13:17:37 INFO - 2015-11-17 13:17:37,828 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [315.79315548315833, 319.2274695237525, 321.736176335405, 322.3987263753101, 323.640758757779, 17028.829711702878, 17437.651246975052, 18201.544961375974, 18886.0, 18895.43313700591, 10936.617218397358, 11055.613053543128, 11319.943400283008, 11321.490532926018, 11325.037371823384, 4493.393391892102, 4607.9308810367875, 4629.814807407716, 4635.6986795858165, 4636.165490211777, 4601.378813860137, 4602.0, 4605.148047611186, 4607.769611519428, 4611.838585649503, 3355.8825441109566, 3456.8444420001033, 4431.623312018466, 4542.682012259143, 4568.657350698711, 4809.975950120262, 4874.610031197513, 4907.214845624719, 4917.680350777206, 4922.433920099199, 4107.342825147992, 4185.874423767292, 4291.785410729451, 4293.720908140961, 4296.720713153666, 11370.147238957112, 11859.703507412298, 12722.554710585086, 13328.067035307533, 13645.113067650671, 1816.2281030561958, 1859.1169194632575, 1892.6971684530547, 1902.1037366654107, 1957.0410498855601, 10061.0, 10175.236857235737, 10181.185505159643, 10199.18406527476, 10209.2343074269, 1695.5167777183567, 1702.7616133741285, 1711.6747817914681, 1727.6285598596237, 1794.3271273272524, 56157.15764263539, 56363.436365636226, 56629.43370566324, 57223.14165287524, 59030.70484647549, 6692.665366731644, 6830.897536536956, 7085.43316534676, 7134.143902731706, 7193.0, 8462.0, 8465.449745766506, 8471.872921906177, 8474.406791524658, 8489.151084891462, 5430.70131142791, 5496.5053145217125, 5570.108782594765, 5612.887742245132, 5618.4662457066515, 5620.57845661577, 5662.858428539237, 5670.404607516234, 5671.120976248688, 5707.543396528268, 3272.885449009273, 3320.93358132836, 3341.986691731569, 3344.7324214062814, 3356.5133055706788, 1159.756451145269, 1170.9121815863843, 1173.8767429419788, 1196.682879037056, 1228.8832560906699, 426.12218829211304, 454.4319600499376, 474.89789695215006, 488.2675986020969, 498.3770287141074, 11259.380734059705, 11710.88289117115, 11815.11386646005, 11967.0, 12077.0, 488.99511004889496, 493.41283872191974, 504.87630530520255, 510.1378670047608, 517.583345406951, 5707.286589176353, 6359.0, 6559.672016399257, 6949.652517374212, 7088.0785497884945, 542603.0, 544043.0, 544791.0, 558882.0, 576089.0, 73449.26550734424, 76561.61719191368, 76911.61544192243, 77001.0, 77732.83400748993, 560.9158626206101, 568.7696482924422, 569.33103603266, 569.3736889421685, 569.6126633888913, 9651.758706032406, 9764.414135151914, 9832.754181145528, 11431.02836258894, 11468.541258349573, 33872.830635846665, 34146.658533414346, 34518.48222276718, 36180.4572931401, 36901.0, 47902.760486197345, 47963.280550792464, 48148.27777583409, 48159.75920120377, 48296.03407931892, 14762.33569489397, 15133.0, 15155.621109472351, 15354.539363819104, 15441.305141268445, 17179.05515196676, 17460.95234285947, 17507.56231094233, 17835.821641783416, 17874.0, 14734.63163420923, 14841.183734894685, 15123.848761512245, 15191.392344306105, 15390.461333853262, 9179.77050573741, 9190.770230744285, 9452.149306562442, 9505.287103467406, 14738.63153421173, 9469.621215151317, 9632.27757918173, 9637.855432168382, 9681.564329605044, 9729.902700973184, 12324.383780811102, 12710.555130570385, 13191.208527488381, 14228.430862765788, 14551.41794328215, 9126.954365228397, 9408.95295523518, 9418.905810941802, 9419.105185007413, 11666.70833229176], "dojo.html": [3147.8583463744135, 3237.33634604906, 3271.738260939125, 3285.769996100274, 3298.0270820108067, 5168.250603662466, 5270.762815673294, 5438.075527160382, 5478.096114141167, 5494.203340515623, 5412.621116521845, 5474.0, 5501.284832971718, 5601.523870471005, 5613.971930140354, 4777.5222477752295, 5039.042581909425, 5066.695998240118, 5102.36220472441, 5154.768035438415, 5140.1518749406305, 5158.3552055993005, 5210.062188806013, 5212.426633070379, 5212.921806172911, 4856.15017371962, 4939.58013568847, 5005.299258103868, 5008.398992120969, 5051.368578927634, 4939.431965323998, 4940.876478088041, 4943.802247910079, 4953.678010929314, 5020.824271150492, 4910.926336104962, 4927.211646136637, 4933.703977761345, 4936.160852655022, 4999.725015124167, 5213.6089793265655, 5248.921266181011, 5357.598180136505, 5361.0, 5459.781608735646, 5888.705564721747, 5999.910001349983, 6007.309159446632, 6012.639241645472, 6019.729112189962, 5986.102084687332, 6001.399860014008, 6007.669578173199, 6010.669413182273, 6012.368701286389, 5327.121025030904, 5444.50999410055, 5539.446055394428, 5635.239242702265, 5652.434756524314, 5918.201042859245, 5938.732757025944, 5942.821715348547, 5957.970210148921, 5984.491318237999, 5731.598788084877, 5779.595428319977, 5786.363500014995, 5790.218320526675, 5823.359430462646, 5761.308642962871, 5843.152742852262, 5866.120081987736, 5872.265966754156, 5876.794312199053, 5816.505597024216, 5822.155787410887, 5822.417758224144, 5823.88352232953, 5827.096799996008, 5830.941690583125, 5834.504067154255, 5835.620684655484, 5836.795712150054, 5838.32859221195, 4396.802143903532, 4447.132809102194, 4465.843695470643, 4477.686561940698, 4542.818287268538, 4042.2521833460905, 4045.8381664733083, 4047.4131250968444, 4059.3099173140636, 4079.9800049987502, 5618.550515958796, 5619.0, 5619.522340601095, 5620.409856965041, 5621.80323688669, 5750.626209296466, 5823.126531020381, 5869.090291004901, 5904.468597826216, 5917.792877249276, 5565.860853478614, 5570.136628822539, 5572.192032155396, 5575.776968921197, 5603.7478313475995, 5112.71880046601, 5115.283860259567, 5119.974400127976, 5123.7438128093445, 5135.97432012845, 5905.379935106838, 5992.670403127782, 6056.121862329937, 6098.878022439526, 6099.085137229451, 5967.940320596912, 6003.879922401615, 6076.0, 6084.178635884099, 6088.695565221633, 6145.348866191089, 6203.131561581473, 6205.441510264098, 6216.689165541795, 6221.875562488815, 5664.5751568631695, 5769.8557536061935, 5940.544765679217, 5952.702364881652, 6011.068284415923, 5751.309842818889, 5833.0, 5838.065909454467, 5839.854003649943, 5870.119482077723, 5772.018756811436, 5777.480026797441, 5801.1878337033695, 5819.0, 5819.621724587888, 5647.519960803378, 5661.065924122474, 5791.305043394819, 5797.246357973437, 5798.797042103506, 5714.142878568082, 5715.428457154251, 5721.199032135588, 5723.8855222896145, 5760.798372056958, 5776.884462310646, 5805.477507024219, 5814.592978491465, 5815.185873977562, 5887.558433117448, 5570.832875013756, 5610.270664813548, 5699.601027928005, 5728.513076388387, 5828.562857785599], "mootools.html": [1372.1492674541785, 1730.1435789284303, 1774.7515347851304, 1799.6130831871149, 1800.6218694074244, 6566.441852442542, 7525.623718814065, 7802.96098519508, 7805.297523222909, 7820.608969551528, 7662.310392064713, 7768.378529717623, 7769.106552746436, 7772.533647981125, 7794.103678077023, 1915.0999030455664, 1939.5829896572234, 2035.1452389996236, 2057.0743165575477, 2236.798688118069, 2246.528229071897, 2250.17868478006, 2253.188852013274, 2255.76314486979, 2255.8533695309834, 2162.935111946644, 2235.966460503094, 2236.183792915582, 2236.821054315651, 2237.641977283635, 1939.1952339778975, 1992.063730046883, 2212.1814928476488, 2263.5246598214394, 2273.7385200701965, 2251.819854411643, 2259.762724913877, 2284.4403121235405, 2287.645414960684, 2320.9767902320928, 7799.181085985946, 7862.01724784402, 7863.606819659051, 7866.488678235896, 7882.842343153105, 4602.0, 4638.489766125724, 4648.48866624671, 4667.953320466786, 4694.600958918496, 2994.6556146043267, 3036.5748795168693, 3046.2116793051982, 3058.632964044307, 3104.2394613319657, 956.8229877472689, 974.4786539201493, 983.6065573770477, 990.267202270322, 1039.6673064619324, 10636.36181829085, 10644.254902156852, 10668.839967400496, 10671.0, 10694.091002264817, 4072.3687828386646, 4112.0, 4123.773192474383, 4238.660907127422, 4247.214265360918, 9167.724968250963, 9171.220446262143, 9189.3108016899, 9242.0, 9249.676261330957, 4660.813567457264, 4694.600958918462, 4697.8590642280105, 4702.811887524529, 4707.270373092176, 4224.556421575752, 4241.0, 4242.787860606957, 4246.5116511600945, 4250.277452833026, 3579.302036102987, 3625.510556074949, 3628.600853906068, 3653.1597732521136, 3657.7256705747177, 1136.5169802833764, 1162.0471213604762, 1163.4531770068054, 1168.2348062019391, 1169.818678104895, 1321.3459337627935, 1324.059917458596, 1339.4776037345443, 1355.8915286777035, 1358.7825947848296, 7376.114866216089, 7617.923820761832, 7740.26467485588, 7787.06555213378, 7793.688252469838, 1033.075397519216, 1054.8892366301582, 1133.21241736992, 1133.2916926920675, 1154.1055681846635, 5889.146073819272, 5918.852028699317, 5924.0, 5935.703214839241, 5935.821925342247, 9328.207102396373, 9350.719478415658, 9520.000399958044, 9715.36850104741, 9716.514174291256, 9465.763355916019, 9543.761405964906, 9600.951995239979, 9628.0, 9641.614335426504, 7069.9646501767165, 7183.748568800067, 7193.89209161863, 7214.494985350975, 7223.92776072243, 6909.516333856582, 6927.134108236471, 6947.062146610143, 6949.722011119701, 6952.130983627047, 7799.103103143211, 8105.797355066171, 8107.3108785753875, 8123.75628731139, 8234.176582341717, 8300.086990430927, 8320.251177394064, 8338.916610834056, 8482.830343392974, 8503.574821259035, 6712.765053223114, 6857.759978400732, 7077.752278670222, 7124.0, 7129.893051604334, 7596.392288617008, 7651.120121186135, 7657.425693072931, 7667.69329226847, 7667.846643067219, 6204.875902481835, 7011.0, 7059.858802824017, 7139.500234983501, 7215.278472152742, 6997.965010174917, 7064.116985376828, 7120.287971202838, 7126.0, 7160.033395491542, 7140.892886606601, 7196.604186769778, 7199.640017999184, 7207.8558428832175, 7208.35124838767, 6642.236142843635, 6689.5986240825705, 6691.1636045494315, 6702.028205910213, 6704.094947182068, 6618.8345291368105, 6686.364795344434, 6701.32986701326, 6701.631410272482, 6713.6643167842385], "ext.html": [541.3198158396502, 579.9101139323406, 585.7510558012846, 601.1703848688809, 607.656673979202, 32091.518627220583, 40104.598954010486, 40876.591234087726, 40890.0, 40903.38644920329, 44235.0, 44424.33363499542, 44723.55276447235, 44965.55034449662, 45021.32468012974, 7593.506422082574, 7725.072991241059, 8733.257673097778, 8888.733337999838, 8913.509756963364, 10560.894391056107, 10816.67549973502, 10818.35089894605, 10848.837267440995, 10874.836877446845, 10524.263301568893, 10602.257841951066, 10620.150387968983, 10627.946860265727, 10628.574857005711, 7899.131095579482, 8019.438639295252, 10499.055085042344, 10673.946630266877, 10997.670069897837, 10472.581096756121, 10609.363438193734, 10613.204009699304, 10620.097291730212, 10623.043926046694, 41191.588084119074, 41512.58487415117, 41540.1691966159, 41710.0, 41711.374329385086, 3088.258817883714, 3130.0296907958605, 3203.5675183850117, 3212.2932954749917, 3419.863205471778, 30304.02254370821, 30554.84722576395, 31096.844515777502, 31311.217219569466, 31845.840770795996, 3525.4888041233876, 3541.0347257272206, 3541.38025845476, 3637.5998640149564, 3660.5790334111653, 275168.0, 277007.0, 277936.0, 277998.0, 278006.0, 58837.70581147067, 59513.0, 59519.404805952254, 59555.10667339993, 59692.104618430756, 56133.0, 56965.43034569684, 63090.36909630937, 68169.65915170491, 69437.65281173562, 15429.151396673291, 15603.843961560466, 15662.216889155497, 15680.215989200495, 15699.136547489998, 11189.552417903356, 11227.775444491064, 11256.774864502828, 11258.437078146224, 11262.099032077414, 19531.414057578295, 19778.0, 19779.20883164686, 19793.703094453595, 19812.108455119553, 7588.8482230356185, 7657.846843063107, 7772.300492955661, 7796.922030779733, 7847.568383738949, 852.4459101583896, 862.1378621378622, 988.4416893908823, 995.6166875752742, 1078.8273876179774, 28711.71288287132, 28875.133745987652, 29518.55722164169, 30135.0, 31635.84182079075, 990.2375171118342, 994.2443742755557, 995.5569771451635, 1067.7330667333167, 1079.6922876980022, 15388.538343849703, 15803.525894223192, 15847.841521584867, 15856.127912964666, 16099.275532601061, 330153.0, 335762.0, 336153.0, 336261.0, 336485.98654148023, 53006.46993530093, 53205.46794532005, 53264.0, 53324.20013699798, 53335.19997200045, 1255.7710064635162, 1257.4341546304017, 1260.9810852837215, 1273.3124112979074, 1429.7497937860833, 26496.470070598865, 29042.27394315159, 29675.406491870475, 29893.70106298909, 30090.84954575213, 43888.34167487426, 44285.33571996358, 44329.77835110933, 44347.0, 44392.334114988946, 267906.0, 269884.0, 269937.0, 270027.0, 270451.0, 27635.861820690767, 28350.858245708638, 31181.0, 31620.683793161774, 32219.0, 38024.0, 38307.0, 38324.233515330096, 38754.2249155021, 39115.0, 32733.836330819147, 33145.668543314256, 33264.537818469704, 33480.832595836866, 35680.183175271006, 31731.20671983219, 34397.82801085978, 35789.64210357863, 36438.63561364352, 36895.44656830096, 35188.64811351854, 35699.286014280086, 35925.64074359223, 36111.819440902626, 36369.45445818262, 28008.29979250535, 28597.28506787347, 31880.68119318777, 35038.47442288317, 36383.81808090943, 24644.0, 25396.365090872878, 25506.872465637553, 25598.488030239663, 25620.0], "prototype.html": [300.2733385207797, 300.4906683172023, 304.5918469251203, 305.95257735051064, 308.1095633618841, 5896.174535565019, 5948.3456819749845, 5978.671173085479, 5986.401359864011, 6045.516358691305, 5706.457886500786, 5777.0756678931375, 5847.590668653196, 5877.2947246330505, 5926.407359264072, 4529.524399937992, 4533.77331133442, 4544.068465964469, 4553.635709143261, 4558.749268790232, 4345.826166953334, 4547.931781023271, 4551.180787458256, 4551.772411379435, 4552.044070745131, 4382.671299652523, 4394.47266328041, 4492.550744925497, 4499.167653984007, 4510.774461276923, 4490.999999999967, 4493.910121797562, 4494.955050449503, 4496.437945256843, 4499.370088187657, 3901.902452438683, 3902.863399780994, 3903.2974064668347, 3905.414187871842, 3908.8241029153473, 5528.06022976091, 5628.183913332544, 5630.549556035548, 5635.80274690388, 5641.435856414367, 5207.297014902978, 5212.061828870802, 5212.218167274901, 5214.687118772886, 5216.26972223889, 6265.624062556261, 6271.0, 6277.623342599459, 6278.215223097113, 6278.968605156945, 4297.763623000734, 4300.440942677463, 4320.1575692739925, 4321.503027151886, 4323.200207961537, 6362.904556431611, 6528.216614006302, 6544.280129185786, 6551.93448065518, 6554.672266386661, 4388.780560972003, 4389.341598760211, 4400.867973960786, 4403.515613282536, 4405.9559404405545, 4448.510663826976, 4448.799804008828, 4453.75504347264, 4454.933176002362, 4458.108378324348, 5190.92213616796, 5192.584593232532, 5194.818181363634, 5197.506236907488, 5203.947960520346, 6280.654563998933, 6336.112944187817, 6364.204474440695, 6378.489720822323, 6386.2975072741965, 1554.968900622004, 1573.5436723350101, 1573.913434761099, 1574.7874037004858, 1577.7791109244715, 1030.7114008077751, 1038.4859494550246, 1040.7918416316768, 1049.7375656085978, 1057.2018126314738, 6132.08018797184, 6143.508519318444, 6147.569670123048, 6148.354422785633, 6154.630722156685, 6546.738130474728, 6547.508936829757, 6556.475481961432, 6559.770408035696, 6560.376764207393, 5991.281046274475, 6020.939790602126, 6120.081987701791, 6123.663198524035, 6132.448079672851, 3528.8588456461453, 3544.2734239480847, 3563.0736008637423, 3564.7326450516316, 3574.0, 6786.69459874297, 6789.5586786859685, 6793.558418702769, 6796.626185559841, 6813.182418109759, 6635.402813746786, 6778.661066946633, 6779.694913728894, 6788.185417749803, 6802.65986700663, 6776.69504872282, 6796.558223715443, 6798.082258895085, 6803.693833777492, 6806.285340039224, 6600.702968366339, 6601.867962640624, 6608.801735947929, 6609.173853268341, 6611.537192396486, 6394.200724909387, 6527.379898909596, 6531.412172904272, 6532.379423954717, 6551.508636852351, 6770.593764374154, 6770.830729231809, 6772.356626120511, 6776.119104516381, 6783.287754785873, 4440.356148358405, 4443.466783985942, 4443.6667249955735, 4446.0, 4459.754713490789, 6455.999320105391, 6591.967040164768, 6597.670116494252, 6598.307177746459, 6598.901016484852, 6410.839729006812, 6425.742970281136, 6426.4216220540375, 6429.678516074271, 6432.839179020562, 6407.199100112486, 6410.775622853178, 6416.807495775134, 6420.582662126947, 6423.710933007932, 6191.102290167991, 6309.0, 6311.337309582611, 6317.052442133717, 6317.905231421624, 6390.7763228286785, 6398.616083035033, 6406.391392817675, 6407.807765767035, 6409.615423074444, 6234.438900498977, 6255.030470277115, 6265.122882796321, 6291.0, 6295.653739044396], "yui.html": [752.8193233623932, 777.3314949143736, 841.7643059943218, 868.5148396242429, 873.2097451806115, 14140.717185656293, 14580.270986450661, 14589.854101458983, 14615.634609134777, 14622.853771462282, 13390.66523336917, 13510.729785404286, 13518.256495892721, 13528.93235533821, 13529.391177397016, 678.2234341678775, 689.176434161175, 823.9876401853977, 828.6975254032295, 843.9324854011695, 827.764087235138, 830.9127541608104, 834.0533494483774, 838.8154605986704, 839.6851180807197, 857.8112815180682, 871.1375738019346, 871.1636828644508, 871.3290766110091, 871.9433236839585, 708.1219288082792, 717.8671945690064, 857.0401150711212, 877.9956100219522, 878.2710350409145, 623.4233334165879, 630.492453574872, 635.8696467224208, 636.9745210191587, 638.7349250061219, 13366.46534138643, 13378.799318010238, 13428.664283392896, 13491.595252142451, 13515.391807368595, 11275.548978040868, 11346.149038822039, 12764.425600847984, 12997.545085922042, 13061.804072938914, 10535.947320263427, 10633.5214915329, 10752.086072683831, 10763.892361076445, 10879.619213327496, 3638.9272214555563, 3698.33429982603, 3706.499622550948, 3744.1762812181278, 3818.6754125899333, 43028.92427689301, 43577.78211108924, 43923.34114988278, 44860.55139448596, 49296.75351623219, 10421.791564168674, 10643.733906652396, 10648.0, 10651.786964260671, 10814.29707069038, 19123.90438047801, 19274.518137046685, 19293.421197364103, 19303.0, 19344.032798360025, 7745.690172393154, 7888.605569721606, 7895.131535531087, 7924.524528528192, 8014.8069489447325, 3980.434814928622, 4024.879253622396, 4044.939325910114, 4076.8165432555606, 4095.5699651536756, 3116.703913128249, 3132.561441398206, 3134.952975705366, 3138.4037032963665, 3148.449021421242, 483.1134420089556, 487.40779952358054, 487.4516169309527, 489.8089744999453, 490.673701988181, 674.3930462583616, 684.1824020295799, 694.1947341084318, 694.8645014222178, 729.5075823818901, 8691.348148888732, 9159.404638698463, 9456.763580910532, 9891.505424728735, 10065.547274849583, 697.6442014572605, 707.9964600177069, 722.6675729164643, 729.3836707981746, 731.4294850016995, 4154.50145982478, 4354.303311470149, 4466.503721253352, 4527.139843429738, 4546.840860569864, 59922.70038649779, 63143.684281578295, 63346.0, 63407.04889426662, 63493.36506634967, 50384.0, 50762.74618626883, 51191.23213151806, 51196.488035119175, 52127.47872521302, 46295.76852115718, 46296.76851615653, 46326.305105423446, 46666.5333346669, 46745.0, 9005.099490050943, 9066.410683305565, 9193.540322983958, 9301.441913485212, 9529.380590261611, 35988.64011359853, 36279.455808163424, 36638.450423244205, 37419.81290093532, 37537.2492550142, 45863.54136458593, 45876.31185532286, 46499.30251046169, 46870.0, 47255.763721181174, 7627.809304767426, 7776.766696999099, 8231.794205144679, 8295.83408331818, 8423.326133909395, 12499.500019999097, 12572.685682858002, 12712.427940742504, 12755.61733148007, 12793.104482686123, 11025.283356581796, 11414.315141091562, 11416.486258118572, 11849.466773995018, 12321.014318854292, 12202.206856554296, 12271.325077120844, 12442.129050966345, 12622.431990560262, 12725.61823145307, 11593.768124637292, 11788.528458861549, 11818.704532386415, 12184.634460966185, 12245.448954796877, 9899.50502474859, 10119.59521619127, 10151.64469243573, 10723.463826808784, 10751.516181771996, 9831.754206144904, 10265.2301077418, 10269.589216431259, 10329.173666106542, 10352.0]}, "summary": {"lowerIsBetter": false, "suite": 6821.405250676534, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7224.364399350839, "unit": "ms", "value": 7224.364399350839}, "dojo.html": {"lowerIsBetter": false, "filtered": 5435.450959425637, "unit": "ms", "value": 5435.450959425637}, "mootools.html": {"lowerIsBetter": false, "filtered": 4497.430329944395, "unit": "ms", "value": 4497.430329944395}, "ext.html": {"lowerIsBetter": false, "filtered": 18690.32801350828, "unit": "ms", "value": 18690.32801350828}, "prototype.html": {"lowerIsBetter": false, "filtered": 4746.132019957465, "unit": "ms", "value": 4746.132019957465}, "yui.html": {"lowerIsBetter": false, "filtered": 6430.575621678621, "unit": "ms", "value": 6430.575621678621}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447793845, "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": "20151117113016", "branch": "Fx-Team", "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 163.0, 160.0, 159.0, 162.0, 161.0, 164.0, 161.0, 163.0], "ai-astar": [107.0, 109.0, 104.0, 110.0, 109.0, 110.0, 97.0, 108.0, 110.0, 108.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0], "audio-beat-detection": [149.0, 124.0, 162.0, 162.0, 127.0, 151.0, 148.0, 142.0, 169.0, 131.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 82.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [141.0, 150.0, 150.0, 149.0, 152.0, 142.0, 151.0, 142.0, 151.0, 140.0], "json-parse-financial": [58.0, 57.0, 56.0, 57.0, 58.0, 57.0, 60.0, 64.0, 56.0, 55.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 68.0, 66.0, 68.0, 67.0, 68.0, 68.0, 65.0, 68.0], "audio-fft": [71.0, 71.0, 83.0, 91.0, 72.0, 72.0, 72.0, 97.0, 92.0, 72.0], "imaging-darkroom": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0], "stanford-crypto-ccm": [120.0, 117.0, 117.0, 123.0, 124.0, 114.0, 125.0, 119.0, 123.0, 127.0], "audio-oscillator": [90.0, 91.0, 135.0, 91.0, 90.0, 90.0, 133.0, 90.0, 91.0, 133.0], "stanford-crypto-aes": [84.0, 84.0, 83.0, 85.0, 84.0, 86.0, 84.0, 91.0, 84.0, 84.0], "imaging-desaturate": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.6, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.3, "unit": "ms", "value": 79.3}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 146.8, "unit": "ms", "value": 146.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 146.5, "unit": "ms", "value": 146.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 120.9, "unit": "ms", "value": 120.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.8, "unit": "ms", "value": 57.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.4, "unit": "ms", "value": 103.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 107.2, "unit": "ms", "value": 107.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.6, "unit": "ms", "value": 161.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.3, "unit": "ms", "value": 67.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.9, "unit": "ms", "value": 109.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.9, "unit": "ms", "value": 84.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447793845, "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": "20151117113016", "branch": "Fx-Team", "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726"}}, {"talos_counters": {}, "results": {"DeltaBlue": [188.040616773223], "Encrypt": [285.06271379703537], "NavierStokes": [4835.748792270531], "Decrypt": [5020.0], "Splay": [664.0368178829717], "Richards": [162.60162601626016], "RegExp": [25717.94871794872], "Earley": [778.816199376947], "Boyer": [12144.578313253012], "RayTrace": [1104.9723756906078]}, "summary": {"lowerIsBetter": false, "suite": 20976.85339311882, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 351.6155239999999, "unit": "score", "value": 351.6155239999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 933.7629479999997, "unit": "score", "value": 933.7629479999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 53.0241035856574, "unit": "score", "value": 53.0241035856574}, "Splay": {"lowerIsBetter": false, "filtered": 122.72060495049507, "unit": "score", "value": 122.72060495049507}, "RegExp": {"lowerIsBetter": false, "filtered": 35.42214855433696, "unit": "score", "value": 35.42214855433696}, "Richards": {"lowerIsBetter": false, "filtered": 217.10729999999992, "unit": "score", "value": 217.10729999999992}, "Earley": {"lowerIsBetter": false, "filtered": 855.7384919999998, "unit": "score", "value": 855.7384919999998}, "Boyer": {"lowerIsBetter": false, "filtered": 54.87740972222223, "unit": "score", "value": 54.87740972222223}, "RayTrace": {"lowerIsBetter": false, "filtered": 669.6900450000003, "unit": "score", "value": 669.6900450000003}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-041"}, "testrun": {"date": 1447793845, "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": "20151117113016", "branch": "Fx-Team", "revision": "3b0264d42bf5cf645bcc0dea69c9c0a2ac52d726"}}] 13:17:37 INFO - RETURN: dromaeo_css: 6821.40 13:17:37 INFO - RETURN: kraken: 1496.60 13:17:37 INFO - RETURN: v8_7: 20976.85 13:17:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20976.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6821.40"}}} 13:17:37 INFO - Return code: 0 13:17:37 INFO - # TBPL SUCCESS # 13:17:37 INFO - Running post-action listener: _resource_record_post_action 13:17:37 INFO - Running post-run listener: _resource_record_post_run 13:17:38 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512360448; Read time: 40; Write time: 506220 13:17:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237817856; Read time: 0; Write time: 299904 13:17:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271974400; Read time: 40; Write time: 182072 13:17:39 INFO - Running post-run listener: _upload_blobber_files 13:17:39 INFO - Blob upload gear active. 13:17:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:17:39 INFO - Copying logs to upload dir... 13:17:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.452140 ========= master_lag: -0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-17 13:17:38.170075) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 13:17:38.173525) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010014 build_url: 'https://queue.taskcluster.net/v1/task/QhKaBopFQFOHBE6nTLVcIA/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-17 13:17:38.224948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:17:38.225286) ========= 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=7f67ac1ceef7774224e327f2000001f6-1447793517.996871-1413813036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 13:17:38.275087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 13:17:38.275411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 13:17:38.275733) ========= ========= Total master_lag: -0.16 =========