builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1447256421.54 results: success (0) buildid: 20151111053051 builduid: 6a9668e43b684387a3ab70a7563b930c revision: 2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.539468) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.539946) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.540272) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.598632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.599018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.618848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.619164) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.688836) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.689340) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.689933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.690438) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-11 07:40:21-- 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% 221M=0s 2015-11-11 07:40:21 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.898400) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.898757) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017123 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.949282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:21.949898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907 --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 2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907 --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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-11 07:40:22,014 truncating revision to first 12 chars 2015-11-11 07:40:22,014 Setting DEBUG logging. 2015-11-11 07:40:22,014 attempt 1/10 2015-11-11 07:40:22,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2fc4d36aa306?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 07:40:22,264 unpacking tar archive at: fx-team-2fc4d36aa306/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:22.480980) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:22.481515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:22.492995) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:22.493404) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 07:40:22.493909) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-11 07:40:22.494560) ========= /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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:40:22 INFO - MultiFileLogger online at 20151111 07:40:22 in /builds/slave/test-pgo 07:40:22 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 07:40:22 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:40:22 INFO - {'append_to_log': False, 07:40:22 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:40:22 INFO - 'blob_upload_branch': 'Fx-Team', 07:40:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:40:22 INFO - 'branch': 'Fx-Team', 07:40:22 INFO - 'buildbot_json_path': 'buildprops.json', 07:40:22 INFO - 'config_files': ('talos/linux_config.py',), 07:40:22 INFO - 'default_actions': ('clobber', 07:40:22 INFO - 'read-buildbot-config', 07:40:22 INFO - 'download-and-extract', 07:40:22 INFO - 'populate-webroot', 07:40:22 INFO - 'create-virtualenv', 07:40:22 INFO - 'install', 07:40:22 INFO - 'run-tests'), 07:40:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:40:22 INFO - 'download_minidump_stackwalk': True, 07:40:22 INFO - 'download_symbols': 'ondemand', 07:40:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:40:22 INFO - 'tooltool.py': '/tools/tooltool.py', 07:40:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:40:22 INFO - '/tools/misc-python/virtualenv.py')}, 07:40:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:40:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:40:22 INFO - 'installer_path': 'installer.exe', 07:40:22 INFO - 'log_level': 'info', 07:40:22 INFO - 'log_name': 'talos', 07:40:22 INFO - 'log_to_console': True, 07:40:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:40:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:40:22 INFO - 'opt_config_files': (), 07:40:22 INFO - 'pip_index': False, 07:40:22 INFO - 'sps_profile': False, 07:40:22 INFO - 'sps_profile_interval': 0, 07:40:22 INFO - 'suite': 'dromaeojs', 07:40:22 INFO - 'system_bits': '64', 07:40:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:40:22 INFO - 'title': 'talos-linux64-ix-016', 07:40:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:40:22 INFO - 'use_talos_json': True, 07:40:22 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:40:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:40:22 INFO - 'work_dir': 'build'} 07:40:22 INFO - ##### 07:40:22 INFO - ##### Running clobber step. 07:40:22 INFO - ##### 07:40:22 INFO - Running pre-action listener: _resource_record_pre_action 07:40:22 INFO - Running main action method: clobber 07:40:22 INFO - rmtree: /builds/slave/test-pgo/build 07:40:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:40:23 INFO - Running post-action listener: _resource_record_post_action 07:40:23 INFO - ##### 07:40:23 INFO - ##### Running read-buildbot-config step. 07:40:23 INFO - ##### 07:40:23 INFO - Running pre-action listener: _resource_record_pre_action 07:40:23 INFO - Running main action method: read_buildbot_config 07:40:23 INFO - Using buildbot properties: 07:40:23 INFO - { 07:40:23 INFO - "properties": { 07:40:23 INFO - "buildnumber": 772, 07:40:23 INFO - "product": "firefox", 07:40:23 INFO - "script_repo_revision": "production", 07:40:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:40:23 INFO - "repository": "", 07:40:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:40:23 INFO - "buildid": "20151111053051", 07:40:23 INFO - "slavename": "talos-linux64-ix-016", 07:40:23 INFO - "pgo_build": "True", 07:40:23 INFO - "basedir": "/builds/slave/test-pgo", 07:40:23 INFO - "project": "", 07:40:23 INFO - "platform": "ubuntu64_hw", 07:40:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:40:23 INFO - "slavebuilddir": "test", 07:40:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:40:23 INFO - "branch": "fx-team", 07:40:23 INFO - "repo_path": "integration/fx-team", 07:40:23 INFO - "stage_platform": "linux64-pgo", 07:40:23 INFO - "builduid": "6a9668e43b684387a3ab70a7563b930c", 07:40:23 INFO - "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907" 07:40:23 INFO - }, 07:40:23 INFO - "sourcestamp": { 07:40:23 INFO - "repository": "", 07:40:23 INFO - "hasPatch": false, 07:40:23 INFO - "project": "", 07:40:23 INFO - "branch": "fx-team-linux64-pgo-talos", 07:40:23 INFO - "changes": [ 07:40:23 INFO - { 07:40:23 INFO - "category": null, 07:40:23 INFO - "files": [ 07:40:23 INFO - { 07:40:23 INFO - "url": null, 07:40:23 INFO - "name": "https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:40:23 INFO - } 07:40:23 INFO - ], 07:40:23 INFO - "repository": "", 07:40:23 INFO - "rev": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907", 07:40:23 INFO - "who": "sendchange", 07:40:23 INFO - "when": 1447256373, 07:40:23 INFO - "number": 6648667, 07:40:23 INFO - "comments": "", 07:40:23 INFO - "project": "", 07:40:23 INFO - "at": "Wed 11 Nov 2015 07:39:33", 07:40:23 INFO - "branch": "fx-team-linux64-pgo-talos", 07:40:23 INFO - "revlink": "", 07:40:23 INFO - "properties": [ 07:40:23 INFO - [ 07:40:23 INFO - "buildid", 07:40:23 INFO - "20151111053051", 07:40:23 INFO - "Change" 07:40:23 INFO - ], 07:40:23 INFO - [ 07:40:23 INFO - "builduid", 07:40:23 INFO - "6a9668e43b684387a3ab70a7563b930c", 07:40:23 INFO - "Change" 07:40:23 INFO - ], 07:40:23 INFO - [ 07:40:23 INFO - "pgo_build", 07:40:23 INFO - "True", 07:40:23 INFO - "Change" 07:40:23 INFO - ] 07:40:23 INFO - ], 07:40:23 INFO - "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907" 07:40:23 INFO - } 07:40:23 INFO - ], 07:40:23 INFO - "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907" 07:40:23 INFO - } 07:40:23 INFO - } 07:40:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:40:23 INFO - Running post-action listener: _resource_record_post_action 07:40:23 INFO - ##### 07:40:23 INFO - ##### Running download-and-extract step. 07:40:23 INFO - ##### 07:40:23 INFO - Running pre-action listener: _resource_record_pre_action 07:40:23 INFO - Running main action method: download_and_extract 07:40:23 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:23 INFO - https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:40:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/test_packages.json 07:40:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/test_packages.json 07:40:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:40:23 INFO - Downloaded 1302 bytes. 07:40:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:40:23 INFO - Using the following test package requirements: 07:40:23 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:23 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:40:23 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'jsshell-linux-x86_64.zip'], 07:40:23 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:40:23 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:23 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:40:23 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:40:23 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:40:23 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:40:23 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:40:23 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:40:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:23 INFO - https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:40:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:25 INFO - Downloaded 22437478 bytes. 07:40:25 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 07:40:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:25 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 07:40:26 INFO - Return code: 0 07:40:26 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 07:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:26 INFO - https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:40:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:27 INFO - Downloaded 22437478 bytes. 07:40:27 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 07:40:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:40:27 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 07:40:29 INFO - Return code: 0 07:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:29 INFO - https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:40:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:40:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:40:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:30 INFO - Downloaded 11131693 bytes. 07:40:30 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 07:40:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:40:30 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 07:40:31 INFO - Return code: 0 07:40:31 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')]} 07:40:31 INFO - https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:40:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:40:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:40:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/jm2JNOPDRTq9nn1D7lie8A/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 07:40:34 INFO - Downloaded 57161267 bytes. 07:40:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:40:34 INFO - mkdir: /builds/slave/test-pgo/properties 07:40:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:40:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:40:34 INFO - Contents: 07:40:34 INFO - build_url:https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:40:34 INFO - Running post-action listener: _resource_record_post_action 07:40:34 INFO - Running post-action listener: set_extra_try_arguments 07:40:34 INFO - ##### 07:40:34 INFO - ##### Running populate-webroot step. 07:40:34 INFO - ##### 07:40:34 INFO - Running pre-action listener: _resource_record_pre_action 07:40:34 INFO - Running main action method: populate_webroot 07:40:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:40:34 INFO - '../fennec_ids.txt'], 07:40:34 INFO - 'tests': ['tcheck2']}, 07:40:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:34 INFO - '--tppagecycles', 07:40:34 INFO - '7'], 07:40:34 INFO - 'tests': ['tsvgm']}}, 07:40:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:40:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:40:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:40:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:40:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'tests': ['damp', 'tps']}, 07:40:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['damp', 'tps']}, 07:40:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:40:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:34 INFO - 'other': {'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'other_l64': {'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'other_nol64': {'tests': ['a11yr', 07:40:34 INFO - 'ts_paint', 07:40:34 INFO - 'tpaint', 07:40:34 INFO - 'sessionrestore', 07:40:34 INFO - 'sessionrestore_no_auto_restore']}, 07:40:34 INFO - 'svgr': {'tests': ['tsvgx', 07:40:34 INFO - 'tsvgr_opacity', 07:40:34 INFO - 'tart', 07:40:34 INFO - 'tscrollx', 07:40:34 INFO - 'cart']}, 07:40:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['tsvgx', 07:40:34 INFO - 'tsvgr_opacity', 07:40:34 INFO - 'tart', 07:40:34 INFO - 'tscrollx', 07:40:34 INFO - 'cart']}, 07:40:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'tests': ['tp5o']}, 07:40:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'talos_options': ['--e10s'], 07:40:34 INFO - 'tests': ['tp5o']}, 07:40:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'talos_options': ['--xperf_path', 07:40:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:34 INFO - 'tests': ['tp5n']}, 07:40:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:34 INFO - 'talos_options': ['--e10s', 07:40:34 INFO - '--xperf_path', 07:40:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:34 INFO - 'tests': ['tp5n']}}, 07:40:34 INFO - 'talos.zip': {'path': '', 07:40:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:34 INFO - Running post-action listener: _resource_record_post_action 07:40:34 INFO - ##### 07:40:34 INFO - ##### Running create-virtualenv step. 07:40:34 INFO - ##### 07:40:34 INFO - Running pre-action listener: _resource_record_pre_action 07:40:34 INFO - Running main action method: create_virtualenv 07:40:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:40:34 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 07:40:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:40:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:34 INFO - Using real prefix '/usr' 07:40:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:40:35 INFO - Installing distribute.............................................................................................................................................................................................done. 07:40:37 INFO - Installing pip.................done. 07:40:37 INFO - Return code: 0 07:40:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:37 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:37 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 07:40:37 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 07:40:37 INFO - Using env: {'DISPLAY': ':0', 07:40:37 INFO - 'HOME': '/home/cltbld', 07:40:37 INFO - 'LANG': 'en_US.UTF-8', 07:40:37 INFO - 'LANGUAGE': 'en_US:en', 07:40:37 INFO - 'LOGNAME': 'cltbld', 07:40:37 INFO - 'MAIL': '/var/mail/cltbld', 07:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:37 INFO - 'MOZ_NO_REMOTE': '1', 07:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:37 INFO - 'NO_EM_RESTART': '1', 07:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:37 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:37 INFO - 'SHELL': '/bin/bash', 07:40:37 INFO - 'SHLVL': '1', 07:40:37 INFO - 'TERM': 'linux', 07:40:37 INFO - 'TMOUT': '86400', 07:40:37 INFO - 'USER': 'cltbld', 07:40:37 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:37 INFO - '_': '/tools/buildbot/bin/python'} 07:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:37 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 07:40:37 INFO - Cleaning up... 07:40:37 INFO - Return code: 0 07:40:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:37 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:37 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 07:40:37 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 07:40:37 INFO - Using env: {'DISPLAY': ':0', 07:40:37 INFO - 'HOME': '/home/cltbld', 07:40:37 INFO - 'LANG': 'en_US.UTF-8', 07:40:37 INFO - 'LANGUAGE': 'en_US:en', 07:40:37 INFO - 'LOGNAME': 'cltbld', 07:40:37 INFO - 'MAIL': '/var/mail/cltbld', 07:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:37 INFO - 'MOZ_NO_REMOTE': '1', 07:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:37 INFO - 'NO_EM_RESTART': '1', 07:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:37 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:37 INFO - 'SHELL': '/bin/bash', 07:40:37 INFO - 'SHLVL': '1', 07:40:37 INFO - 'TERM': 'linux', 07:40:37 INFO - 'TMOUT': '86400', 07:40:37 INFO - 'USER': 'cltbld', 07:40:37 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:37 INFO - '_': '/tools/buildbot/bin/python'} 07:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:37 INFO - Downloading/unpacking psutil>=0.7.1 07:40:37 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 07:40:37 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 07:40:37 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 07:40:37 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 07:40:37 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 07:40:37 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 07:40:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:40:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:40:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:40:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:39 INFO - Installing collected packages: psutil 07:40:39 INFO - Running setup.py install for psutil 07:40:39 INFO - building 'psutil._psutil_linux' extension 07:40:39 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 07:40:39 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 07:40:39 INFO - building 'psutil._psutil_posix' extension 07:40:39 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 07:40:39 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 07:40:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:39 INFO - Successfully installed psutil 07:40:39 INFO - Cleaning up... 07:40:39 INFO - Return code: 0 07:40:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:40:39 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')]} 07:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:39 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')]} 07:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:39 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:39 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 07:40:39 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 07:40:39 INFO - Using env: {'DISPLAY': ':0', 07:40:39 INFO - 'HOME': '/home/cltbld', 07:40:39 INFO - 'LANG': 'en_US.UTF-8', 07:40:39 INFO - 'LANGUAGE': 'en_US:en', 07:40:39 INFO - 'LOGNAME': 'cltbld', 07:40:39 INFO - 'MAIL': '/var/mail/cltbld', 07:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:39 INFO - 'MOZ_NO_REMOTE': '1', 07:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:39 INFO - 'NO_EM_RESTART': '1', 07:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:39 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:39 INFO - 'SHELL': '/bin/bash', 07:40:39 INFO - 'SHLVL': '1', 07:40:39 INFO - 'TERM': 'linux', 07:40:39 INFO - 'TMOUT': '86400', 07:40:39 INFO - 'USER': 'cltbld', 07:40:39 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:39 INFO - '_': '/tools/buildbot/bin/python'} 07:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:40 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 07:40:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:40:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:40:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:40:41 INFO - Installing collected packages: mozsystemmonitor 07:40:41 INFO - Running setup.py install for mozsystemmonitor 07:40:41 INFO - Successfully installed mozsystemmonitor 07:40:41 INFO - Cleaning up... 07:40:42 INFO - Return code: 0 07:40:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:40:42 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')]} 07:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:42 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')]} 07:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:42 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:42 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 07:40:42 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 07:40:42 INFO - Using env: {'DISPLAY': ':0', 07:40:42 INFO - 'HOME': '/home/cltbld', 07:40:42 INFO - 'LANG': 'en_US.UTF-8', 07:40:42 INFO - 'LANGUAGE': 'en_US:en', 07:40:42 INFO - 'LOGNAME': 'cltbld', 07:40:42 INFO - 'MAIL': '/var/mail/cltbld', 07:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:42 INFO - 'MOZ_NO_REMOTE': '1', 07:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:42 INFO - 'NO_EM_RESTART': '1', 07:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:42 INFO - 'SHELL': '/bin/bash', 07:40:42 INFO - 'SHLVL': '1', 07:40:42 INFO - 'TERM': 'linux', 07:40:42 INFO - 'TMOUT': '86400', 07:40:42 INFO - 'USER': 'cltbld', 07:40:42 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:42 INFO - '_': '/tools/buildbot/bin/python'} 07:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:42 INFO - Downloading/unpacking blobuploader==1.2.4 07:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:40:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:40:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:40:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:40:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:40:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:40:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:40:44 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 07:40:44 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 07:40:44 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 07:40:44 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 07:40:44 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 07:40:44 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 07:40:44 INFO - Downloading docopt-0.6.1.tar.gz 07:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:40:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:40:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:40:44 INFO - Running setup.py install for blobuploader 07:40:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:40:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:40:44 INFO - Running setup.py install for requests 07:40:45 INFO - Running setup.py install for docopt 07:40:45 INFO - Successfully installed blobuploader requests docopt 07:40:45 INFO - Cleaning up... 07:40:45 INFO - Return code: 0 07:40:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:45 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:45 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 07:40:45 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 07:40:45 INFO - Using env: {'DISPLAY': ':0', 07:40:45 INFO - 'HOME': '/home/cltbld', 07:40:45 INFO - 'LANG': 'en_US.UTF-8', 07:40:45 INFO - 'LANGUAGE': 'en_US:en', 07:40:45 INFO - 'LOGNAME': 'cltbld', 07:40:45 INFO - 'MAIL': '/var/mail/cltbld', 07:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:45 INFO - 'MOZ_NO_REMOTE': '1', 07:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:45 INFO - 'NO_EM_RESTART': '1', 07:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:45 INFO - 'SHELL': '/bin/bash', 07:40:45 INFO - 'SHLVL': '1', 07:40:45 INFO - 'TERM': 'linux', 07:40:45 INFO - 'TMOUT': '86400', 07:40:45 INFO - 'USER': 'cltbld', 07:40:45 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:45 INFO - '_': '/tools/buildbot/bin/python'} 07:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:40:45 INFO - Running setup.py (path:/tmp/pip-IrvpQ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:40:45 INFO - Running setup.py (path:/tmp/pip-PtPhV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:40:45 INFO - Running setup.py (path:/tmp/pip-N7c2pt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:40:45 INFO - Running setup.py (path:/tmp/pip-OkKvLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:40:45 INFO - Running setup.py (path:/tmp/pip-nVFY3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:40:45 INFO - Running setup.py (path:/tmp/pip-MOMBXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:40:45 INFO - Running setup.py (path:/tmp/pip-B_lxKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:40:45 INFO - Running setup.py (path:/tmp/pip-oFibnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:40:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:40:45 INFO - Running setup.py (path:/tmp/pip-f79qq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:40:46 INFO - Running setup.py (path:/tmp/pip-1_Sy8W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:40:46 INFO - Running setup.py (path:/tmp/pip-2FFFGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:40:46 INFO - Running setup.py (path:/tmp/pip-VhCxGn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:40:46 INFO - Running setup.py (path:/tmp/pip-rZ3kOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:40:46 INFO - Running setup.py (path:/tmp/pip-OLhvUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:40:46 INFO - Running setup.py (path:/tmp/pip-OsBDdS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:40:46 INFO - Running setup.py (path:/tmp/pip-Io_9n5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:40:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:40:46 INFO - Running setup.py (path:/tmp/pip-9qLZPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:40:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:40:46 INFO - Running setup.py install for manifestparser 07:40:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:40:46 INFO - Running setup.py install for mozcrash 07:40:46 INFO - Running setup.py install for mozdebug 07:40:46 INFO - Running setup.py install for mozdevice 07:40:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozfile 07:40:47 INFO - Running setup.py install for mozhttpd 07:40:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozinfo 07:40:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozInstall 07:40:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozleak 07:40:47 INFO - Running setup.py install for mozlog 07:40:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for moznetwork 07:40:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozprocess 07:40:47 INFO - Running setup.py install for mozprofile 07:40:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:40:47 INFO - Running setup.py install for mozrunner 07:40:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:40:48 INFO - Running setup.py install for mozscreenshot 07:40:48 INFO - Running setup.py install for moztest 07:40:48 INFO - Running setup.py install for mozversion 07:40:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:40:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:40:48 INFO - Cleaning up... 07:40:48 INFO - Return code: 0 07:40:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:40:48 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')]} 07:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:48 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')]} 07:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:48 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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:48 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 07:40:48 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 07:40:48 INFO - Using env: {'DISPLAY': ':0', 07:40:48 INFO - 'HOME': '/home/cltbld', 07:40:48 INFO - 'LANG': 'en_US.UTF-8', 07:40:48 INFO - 'LANGUAGE': 'en_US:en', 07:40:48 INFO - 'LOGNAME': 'cltbld', 07:40:48 INFO - 'MAIL': '/var/mail/cltbld', 07:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:48 INFO - 'MOZ_NO_REMOTE': '1', 07:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:48 INFO - 'NO_EM_RESTART': '1', 07:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:48 INFO - 'SHELL': '/bin/bash', 07:40:48 INFO - 'SHLVL': '1', 07:40:48 INFO - 'TERM': 'linux', 07:40:48 INFO - 'TMOUT': '86400', 07:40:48 INFO - 'USER': 'cltbld', 07:40:48 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:48 INFO - '_': '/tools/buildbot/bin/python'} 07:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:40:48 INFO - Running setup.py (path:/tmp/pip-GBp7zE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:40:48 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)) 07:40:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:40:48 INFO - Running setup.py (path:/tmp/pip-5D61Gm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:40:48 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)) 07:40:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:40:48 INFO - Running setup.py (path:/tmp/pip-v1PSts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:40:48 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)) 07:40:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:40:48 INFO - Running setup.py (path:/tmp/pip-dWb2Fo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:40:48 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)) 07:40:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:40:48 INFO - Running setup.py (path:/tmp/pip-a9pbCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:40:49 INFO - Running setup.py (path:/tmp/pip-td6LHU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:40:49 INFO - Running setup.py (path:/tmp/pip-SFP8zg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:40:49 INFO - Running setup.py (path:/tmp/pip-Yugy8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:40:49 INFO - Running setup.py (path:/tmp/pip-9NXMGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:40:49 INFO - Running setup.py (path:/tmp/pip-xPUbzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:40:49 INFO - Running setup.py (path:/tmp/pip-ltXLrw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:40:49 INFO - Running setup.py (path:/tmp/pip-n4ooa8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:40:49 INFO - Running setup.py (path:/tmp/pip-87rP8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:40:49 INFO - Running setup.py (path:/tmp/pip-_ZRplK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:40:49 INFO - Running setup.py (path:/tmp/pip-nyJzTd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:40:49 INFO - Running setup.py (path:/tmp/pip-QFOF8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:40:49 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)) 07:40:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:40:49 INFO - Running setup.py (path:/tmp/pip-Fzp30w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:40:49 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 07:40:49 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 07:40:49 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 07:40:49 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 07:40:49 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 07:40:49 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 07:40:51 INFO - Downloading blessings-1.5.1.tar.gz 07:40:51 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 07:40:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:40:51 INFO - Installing collected packages: blessings 07:40:51 INFO - Running setup.py install for blessings 07:40:51 INFO - Successfully installed blessings 07:40:51 INFO - Cleaning up... 07:40:51 INFO - Return code: 0 07:40:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:40:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:40:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:40:51 INFO - Reading from file tmpfile_stdout 07:40:51 INFO - Current package versions: 07:40:51 INFO - argparse == 1.2.1 07:40:51 INFO - blessings == 1.5.1 07:40:51 INFO - blobuploader == 1.2.4 07:40:51 INFO - docopt == 0.6.1 07:40:51 INFO - manifestparser == 1.1 07:40:51 INFO - mozInstall == 1.12 07:40:51 INFO - mozcrash == 0.16 07:40:51 INFO - mozdebug == 0.1 07:40:51 INFO - mozdevice == 0.47 07:40:51 INFO - mozfile == 1.2 07:40:51 INFO - mozhttpd == 0.7 07:40:51 INFO - mozinfo == 0.9 07:40:51 INFO - mozleak == 0.1 07:40:51 INFO - mozlog == 3.0 07:40:51 INFO - moznetwork == 0.27 07:40:51 INFO - mozprocess == 0.22 07:40:51 INFO - mozprofile == 0.27 07:40:51 INFO - mozrunner == 6.11 07:40:51 INFO - mozscreenshot == 0.1 07:40:51 INFO - mozsystemmonitor == 0.0 07:40:51 INFO - moztest == 0.7 07:40:51 INFO - mozversion == 1.4 07:40:51 INFO - psutil == 3.1.1 07:40:51 INFO - requests == 1.2.3 07:40:51 INFO - wsgiref == 0.1.2 07:40:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:40:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f9b4e30dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c576c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d183d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, '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': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', '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 07:40:51 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 07:40:51 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 07:40:51 INFO - Using env: {'DISPLAY': ':0', 07:40:51 INFO - 'HOME': '/home/cltbld', 07:40:51 INFO - 'LANG': 'en_US.UTF-8', 07:40:51 INFO - 'LANGUAGE': 'en_US:en', 07:40:51 INFO - 'LOGNAME': 'cltbld', 07:40:51 INFO - 'MAIL': '/var/mail/cltbld', 07:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:51 INFO - 'MOZ_NO_REMOTE': '1', 07:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:51 INFO - 'NO_EM_RESTART': '1', 07:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:40:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:40:51 INFO - 'SHELL': '/bin/bash', 07:40:51 INFO - 'SHLVL': '1', 07:40:51 INFO - 'TERM': 'linux', 07:40:51 INFO - 'TMOUT': '86400', 07:40:51 INFO - 'USER': 'cltbld', 07:40:51 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:51 INFO - '_': '/tools/buildbot/bin/python'} 07:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 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)) 07:40:52 INFO - Cleaning up... 07:40:52 INFO - Return code: 0 07:40:52 INFO - Running post-action listener: _resource_record_post_action 07:40:52 INFO - Running post-action listener: _start_resource_monitoring 07:40:52 INFO - Starting resource monitoring. 07:40:52 INFO - ##### 07:40:52 INFO - ##### Running install step. 07:40:52 INFO - ##### 07:40:52 INFO - Running pre-action listener: _resource_record_pre_action 07:40:52 INFO - Running main action method: install 07:40:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:40:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:40:52 INFO - Reading from file tmpfile_stdout 07:40:52 INFO - Detecting whether we're running mozinstall >=1.0... 07:40:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:40:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:40:52 INFO - Reading from file tmpfile_stdout 07:40:52 INFO - Output received: 07:40:52 INFO - Usage: mozinstall [options] installer 07:40:52 INFO - Options: 07:40:52 INFO - -h, --help show this help message and exit 07:40:52 INFO - -d DEST, --destination=DEST 07:40:52 INFO - Directory to install application into. [default: 07:40:52 INFO - "/builds/slave/test-pgo"] 07:40:52 INFO - --app=APP Application being installed. [default: firefox] 07:40:52 INFO - mkdir: /builds/slave/test-pgo/build/application 07:40:52 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'] 07:40:52 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 07:41:06 INFO - Reading from file tmpfile_stdout 07:41:06 INFO - Output received: 07:41:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:41:06 INFO - Running post-action listener: _resource_record_post_action 07:41:06 INFO - ##### 07:41:06 INFO - ##### Running run-tests step. 07:41:06 INFO - ##### 07:41:06 INFO - Running pre-action listener: _resource_record_pre_action 07:41:06 INFO - Running main action method: run_tests 07:41:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:41:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:41:06 INFO - Python 2.7.3 07:41:06 INFO - Return code: 0 07:41:06 INFO - grabbing minidump binary from tooltool 07:41: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')]} 07:41:06 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 0x1da18c0>, '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 0x1d4e420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d4e8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:41:06 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 07:41:06 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 07:41:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:06 INFO - Return code: 0 07:41:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:41:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:41:06 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/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:41:06 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/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 07:41:06 INFO - Using env: {'DISPLAY': ':0', 07:41:06 INFO - 'HOME': '/home/cltbld', 07:41:06 INFO - 'LANG': 'en_US.UTF-8', 07:41:06 INFO - 'LANGUAGE': 'en_US:en', 07:41:06 INFO - 'LOGNAME': 'cltbld', 07:41:06 INFO - 'MAIL': '/var/mail/cltbld', 07:41:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:41:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:06 INFO - 'MOZ_NO_REMOTE': '1', 07:41:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:06 INFO - 'NO_EM_RESTART': '1', 07:41:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:41:06 INFO - 'SHELL': '/bin/bash', 07:41:06 INFO - 'SHLVL': '1', 07:41:06 INFO - 'TERM': 'linux', 07:41:06 INFO - 'TMOUT': '86400', 07:41:06 INFO - 'USER': 'cltbld', 07:41:06 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1447256018.261488-496606295', 07:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:06 INFO - '_': '/tools/buildbot/bin/python'} 07:41:06 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/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 07:41:07 INFO - mozversion INFO | application_buildid: 20151111053051 07:41:07 INFO - mozversion INFO | application_changeset: 2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907 07:41:07 INFO - mozversion INFO | application_display_name: Nightly 07:41:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:07 INFO - mozversion INFO | application_name: Firefox 07:41:07 INFO - mozversion INFO | application_remotingname: firefox 07:41:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:41:07 INFO - mozversion INFO | application_vendor: Mozilla 07:41:07 INFO - mozversion INFO | application_version: 45.0a1 07:41:07 INFO - mozversion INFO | platform_buildid: 20151111053051 07:41:07 INFO - mozversion INFO | platform_changeset: 2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907 07:41:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:41:07 INFO - mozversion INFO | platform_version: 45.0a1 07:41:07 INFO - 2015-11-11 07:41:07,114 DEBUG : using testdate: 1447256467 07:41:07 INFO - 2015-11-11 07:41:07,114 DEBUG : actual date: 1447256467 07:41:07 INFO - 2015-11-11 07:41:07,123 INFO : starting webserver on 'localhost:35148' 07:41:07 INFO - 2015-11-11 07:41:07,124 INFO : Starting test suite talos-linux64-ix-016 07:41:07 INFO - 2015-11-11 07:41:07,124 INFO : Starting test dromaeo_css 07:41:07 INFO - 2015-11-11 07:41:07,124 DEBUG : operating with platform_type : linux_ 07:41:07 INFO - 2015-11-11 07:41:07,125 INFO : Initialising browser for dromaeo_css test... 07:41:07 INFO - 2015-11-11 07:41:07,141 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbHddeh/profile http://localhost:35148/getInfo.html 07:41:11 INFO - 2015-11-11 07:41:11,060 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:41:11 INFO - 2015-11-11 07:41:11,061 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:41:11 INFO - 2015-11-11 07:41:11,061 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:41:11 INFO - 2015-11-11 07:41:11,061 DEBUG : BROWSER_OUTPUT: __metrics 07:41:11 INFO - 2015-11-11 07:41:11,157 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:12 INFO - 2015-11-11 07:41:12,410 INFO : Browser initialized. 07:41:12 INFO - 2015-11-11 07:41:12,410 INFO : Running cycle 1/1 for dromaeo_css test... 07:41:12 INFO - 2015-11-11 07:41:12,411 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbHddeh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:41:24 INFO - 2015-11-11 07:41:24,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 141975552 07:41:24 INFO - 2015-11-11 07:41:24,084 DEBUG : BROWSER_OUTPUT: 07:42:15 INFO - 2015-11-11 07:42:15,375 DEBUG : BROWSER_OUTPUT: 1447256535373 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] 07:44:23 INFO - 2015-11-11 07:44:23,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35148/tests/dromaeo/cssquery-ext.html) 07:44:24 INFO - 2015-11-11 07:44:24,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 232837120 07:44:24 INFO - 2015-11-11 07:44:24,788 DEBUG : BROWSER_OUTPUT: 07:47:27 INFO - 2015-11-11 07:47:27,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-ext.html (next: http://localhost:35148/tests/dromaeo/cssquery-jquery.html) 07:47:27 INFO - 2015-11-11 07:47:27,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 221155328 07:47:27 INFO - 2015-11-11 07:47:27,629 DEBUG : BROWSER_OUTPUT: 07:50:29 INFO - 2015-11-11 07:50:29,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35148/tests/dromaeo/cssquery-mootools.html) 07:50:30 INFO - 2015-11-11 07:50:30,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 216576000 07:50:30 INFO - 2015-11-11 07:50:30,090 DEBUG : BROWSER_OUTPUT: 07:53:31 INFO - 2015-11-11 07:53:31,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35148/tests/dromaeo/cssquery-prototype.html) 07:53:32 INFO - 2015-11-11 07:53:32,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 200884224 07:53:32 INFO - 2015-11-11 07:53:32,537 DEBUG : BROWSER_OUTPUT: 07:56:34 INFO - 2015-11-11 07:56:34,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35148/tests/dromaeo/cssquery-yui.html) 07:56:35 INFO - 2015-11-11 07:56:35,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 199639040 07:56:35 INFO - 2015-11-11 07:56:35,539 DEBUG : BROWSER_OUTPUT: 07:59:37 INFO - 2015-11-11 07:59:37,977 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/dromaeo/cssquery-yui.html (next: http://localhost:35148/tests/dromaeo/cssquery-dojo.html) 07:59:38 INFO - 2015-11-11 07:59:38,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 250322944 07:59:38 INFO - 2015-11-11 07:59:38,221 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,222 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:59:38 INFO - 2015-11-11 07:59:38,222 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:59:38 INFO - 2015-11-11 07:59:38,223 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:59:38 INFO - 2015-11-11 07:59:38,223 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:59:38 INFO - 2015-11-11 07:59:38,226 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3154.8107113573187;3184.8248346340943;3226.145071556037;3226.983865080674;3248.2204270974958;5186.455422180673;5272.973635131823;5304.124819404794;5307.097793375126;5341.305630268064;5261.1319132343115;5309.177077552976;5311.57507399408;5317.308749862513;5319.893602127965;4678.883027924295;4819.975900120495;4836.733979631119;4839.782209800559;4921.335619691349;4760.619150467955;4978.153713868633;4993.6254780891395;5015.5736762375245;5082.466341034194;4777.06847164803;4880.341153944208;4887.804487820483;4924.80300787968;4931.876703082416;4855.757212139379;4856.2958371036;4870.65905386623;4884.731339776311;4892.559669629715;4775.14047471455;4840.854774356775;4841.443234028096;4843.75781210938;4889.755512224375;5089.440161582223;5121.641485096045;5195.792168313263;5202.661826981234;5238.633295669267;5861.3552509223955;5863.5016023638045;5866.032104702719;5879.412058794129;5886.05823068307;5760.9711951440395;5874.1776151338845;5886.882262354772;5899.203607512974;5911.379305172938;5375.408705042442;5438.428964958702;5444.50999410055;5448.891022179534;5490.176473529003;5872.29532456108;5878.382769809194;5905.645661260338;5914.378990206053;5923.703814809242;5584.91622625661;5641.689707066151;5709.65742055478;5729.656220626775;5732.197492351074;5666.603337766317;5668.546516278688;5670.177824215548;5670.404607516151;5725.198472213893;5664.830055098354;5667;5671.432856714296;5671.546276297886;5681.715914204273;5630.8029218977135;5691.26013618227;5728.369879313273;5772.480476757112;5884.529237661062;4471.150481408522;4494.213512635276;4499.887502812456;4504.054148628825;4534.455865296186;4007.3988901664984;4008.819603117867;4013.8795836124964;4046.1503084352616;4059.1475790084414;5306.787728490817;5377.892442151213;5412.215228791882;5441.673499590037;5472.288602481732;5781.075027995585;5824.796132135355;5825.912611310834;5826.65040097587;5829.154772557956;5319.308489896289;5478.397376288684;5483.561315094783;5485.341758988947;5489.862753431196;4992.775325110379;5014.824481143142;5068.847934561969;5090.974545127251;5129.333186685707;5994.850128746816;6004.039353703386;6019.307779605314;6019.759209631566;6019.849503762441;5623.353314368736;5786.987277226553;5791.507721843522;5795.8551036224435;5808.970955145366;5905.084711869667;5986.3115741688525;5999.610025348338;6000.459958603747;6037.607555508878;5648.15277708347;5650.576206784425;5651.4348565143155;5680.062789639664;5786.334571524329;5694.4590263924865;5735.254416925773;5741.45456181662;5749.310082790092;5821.650700957956;5640.153976903333;5660.405657405913;5666.688332141772;5668.26312579362;5672.7730890763905;5628.212050312877;5635.520980716685;5647.181158731879;5648.548116150616;5651.745671444713;5408.405075441619;5439.401665816836;5516.117421212587;5547.944520554743;5562.054450743302;5583.888322233452;5711.485966263056;5754.108113242454;5774.1916131740745;5817.680027598522;5579.525740311957;5597.076482380525;5623.746931388016;5634.464725851038;5641.8589535261945 07:59:38 INFO - 2015-11-11 07:59:38,226 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.5883928214556;578.2396149063981;586.2964442668798;587.6268569458396;595.2291782142125;29406;30141;30174.84912575434;39005.609943900556;39844;42837;43176;43188.92027699301;43291.78354108225;43359.56640433602;7647.197044310351;8653.61058752356;8779.517126558037;8801.823963520726;8825.51459669718;7753.922460775405;10396.428196449193;10645.574177032948;10671.039606435419;10679.946600267027;10335.793284134314;10456.268061235716;10465.058144767008;10467.371957682526;10470;7871.527708337518;8061.476004059776;10306.89693103067;10416;10494;10253.795433981655;10394.79210415795;10410.479476026168;10411.94794026025;10413.531391087343;39227.60772392296;39668.60331396678;39681.20637587232;39696.404553931716;39715.20569588621;2770.8735161360887;2908.0984894682715;3184.379046086014;3231.8222497762613;3276.754243431752;28423.85788071067;28744.856275718488;29255.853720731473;29259.56110658342;30030.249243768863;3239.7732158748895;3246.2046798534275;3288.8355582220793;3326.301476689898;3347.598288205431;247350;248222.9999999982;248849;248964;250000;55097.44902551003;55100;55292.170617440774;55541.16688249679;55661.165082523796;57409.71295143497;57482.7125864368;57537.13694294589;57618.135727964116;57659;14789.852101478848;15122.319495622723;15155.393784248727;15170.469033583771;15172.165530895907;12145.63563093091;12206.633800985985;12249.69375765613;12293.692657683629;12303.138780285473;18847.246110155713;18939.242430302635;18945;19105.331313403964;19187.808121918883;7415.629218539051;7475.140358858692;7538.09542854861;7546.773596792105;7572;902.4900930973979;915.2677857713802;946.4179529589253;955.6273053509137;1095.8684957805115;28041.43917121646;28239.57640635392;28241.881858860666;28415.57376639352;28653.14040578786;903.8689390038408;976.8095221431753;1031.0565832263544;1079.4818487126224;1113.549012649878;13532.797008044887;13851.930740346234;14127.081739687093;14132.717345653235;14139.64650883736;326218;330108;332039;332294;332410;43784.78107609505;44824.77587612041;52238.477615224125;53321;53365.19952200643;1330.481112366178;1346.7037251804588;1349.406261245049;1358.538097046989;1364.290568904184;23925.641115382936;28326.716732833233;28855;29857;30659.846700766353;50290.24564631606;50945.23582146345;50953;50984;51014.23478647749;297378;300265;301062;301327;301680;40619.7969010153;41229.587704122576;42540.787296063325;42650.78674606607;42678.57321426746;44617.55382446134;45157;45284.320735189656;45443.772781135885;45938.77030614825;36935.261294773416;37875.242495150495;38549;38571.421428679154;38876.80561597174;38367;39784.40323395209;40967.38548921709;41734.58265417307;42366.5763342375;36317.45523817198;36716.26567468689;36750.081247969014;36852.63147368492;36875.12811154898;29949.401011979204;33148.33703325968;33229.83385083059;33567.664323356454;33689.66310336865;25393.180236604185;25416.364590885376;25813.870930645226;25899.223023309332;26013.479730405663 07:59:38 INFO - 2015-11-11 07:59:38,230 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.82408795602197;352.7848012712246;356.75383985050314;357.05202686866363;357.79426829573003;14044.719105617882;14533.418663253457;16473.34106635733;17182.91408542957;18121.546961325956;11301.378424186667;11743.06055515559;16580.585485362873;17725.7341139883;17727.82272177278;4451.154280686667;4529;4547.840825571106;4555.293929440925;4567.680262381635;3386.1365351835248;3502.6322236165092;4520.525344838794;4558.475775285851;4903;4899.387576552931;4919.065377578267;4937.876553086166;4964.304997300381;4980.900381992358;4843.636727245453;4851.708897466128;4893.657443978923;4924.162892308298;4991.500849914997;4225.492940847087;4242.045539753562;4255.127698821734;4259.1268789897995;4264.424302719155;13506.122102063335;13931.512397066053;13973.371198296;13985.160890346611;13997.020208585403;1677.614148745783;1967.7245185673873;1981.0787983587702;1996.7603887533444;2123.0446299165437;9722.75693107678;9855;9898.455584942825;9965.15296199824;9982.550785214682;1674.673438679458;1675.2293944785292;1679.110071662021;1686.7975842898932;1753.6580366828473;61509;61657.69171154161;63705.04442433321;64402.35597644011;64726;6750.966245168743;6771.3905748482875;6772.356626120511;6817.386435220854;6830.897536536956;8081.151479094728;8142.185781421929;8147.063087744867;8147.918520814835;8158.551279679675;5229.790808367623;5270.60470464709;5277.445868183785;5299.788008479694;5311.256424100629;5250.606204534675;5281.943611277683;5303.549198318109;5325.440828712929;5326.627136100513;3158.6209654841105;3196.2488815128427;3202.279487115427;3217.131374528864;3220.339830334776;1082.4858192358568;1089.8256278995482;1103.564092183583;1129.7345123895877;1164.5632887667125;455.9452865656076;458.3468557305826;474.70331043098065;482.2452861272098;509.68144909431606;10910.23628346024;11303.773924521627;11315.886841131483;11408.657740267805;11899.762004759856;441.72612979952635;493.6914428482199;501.5636396335139;503.2024241577068;504.89649621827436;5835.124731290341;6155.599886007395;6175.722092505848;6259.71831267594;6317.5893566918;488929;492189;526222;526309;537567;71278;71596.64201679062;75694;76647.92694989913;77017.61491192508;559.9104143337128;572.6020415810972;573.3664300947477;573.7217449536971;573.8163787588015;10902.672919812418;11092.778144436905;11291.830622540505;11308.208425410143;11343.659690209306;35145.82427087848;35438;36022.09944751297;36151.45772813463;36264;46962.530374697184;48094.519054809;48883;49116.754416229116;49483.01033979372;6520.18497687789;6663.5002374821115;6773.288804675635;6797.1843378794865;6797.456203503609;12038.879611203776;12219.900208981235;12260.816087758869;12321.815172772594;12359.814602781145;8795.956020219857;10803.729906752395;10882.183836212158;10968.835467468154;11048.392338421463;10150.187984961332;10468.371897686164;10495.370277783357;10793.62222322215;11092.445377730919;8871.911280887109;8887.200151986352;11369.204155709022;11463.942680286546;11476.196666233283;6615.437687796399;6675.198976122896;6693.431058359899;6701.832454188684;6706.228783689938;10337.224708146769;10575.841362379417;10691.786164276515;10698.465076746288;11178.385188814693 07:59:38 INFO - 2015-11-11 07:59:38,230 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1495.9925200373996;1675.7989041315045;1750.6323672028873;1763.1448747357529;1765.5409593505685;6966.895496567556;7577.052868391451;7688.500247483909;7727.652255648495;7730.884036739453;7537.359324457414;7578.317951384374;7600.20197879223;7654.54072755635;7659.731909383173;1990.144237977669;2037.368415791102;2224.477247846755;2267.308470916374;2305.8155347572238;2275.0444813178506;2278.293728944024;2279.5782780185637;2281.7261928568596;2282.2924893283052;2206.680031395447;2290.942726431836;2292.1175347491253;2292.5300313435787;2296.3111066680012;1999.3002449142757;2056.8148866602005;2210.635245184543;2269.47802005538;2271.0802125139344;2222.9888850555644;2225.9109635614554;2258.4015235962484;2261.1068627892055;2268.6370180770996;7616.086069671619;7704.114026886924;7726.845463090706;7739.961300193463;7742.225777422269;4549.840755573539;4616.584507394351;4624.537546245382;4642.210824159867;4646.140464014168;3064.4024415239037;3147.763917706181;3169.0809665197066;3186.2990142168687;3187.043886833964;944.4569372610777;961.4135377419768;976.8437050072025;989.0653332600696;1014.8985101489866;10485.318454300523;10517.1060459861;10618.946905265502;10628.202884783672;10635.840462393071;4066.268071747055;4131.132462182975;4152.211079894811;4160.1471698301775;4237.194932962727;8661;8687.565621718888;8694.782630434163;8698.521581313089;8703.521306328086;4566;4569.451665800125;4598.1033698429155;4606.769661516911;4611.1930412177735;4196.81114349855;4227.3447615619625;4230.957690423118;4232.8518501852905;4236.766977816188;3420.7263418926427;3474.8436320365645;3475.2180759329453;3480.582330120402;3516.5955915070094;1050.6270274052602;1064.4411683866033;1067.4716015572342;1068.1134658233648;1072.5709716113618;1109.417555783204;1296.0603562417361;1304.315234501894;1340.3633274194874;1344.0188662276594;7320.524165929198;7374.225706300868;7395.8151046224275;7401.370883474858;7409.073865766779;1168.6143572621015;1174.618249069056;1179.4869231883986;1210.2466887830258;1213.071999920062;5318.574514038945;5327.360716714019;5334.813281535127;5369.892602147936;5374.059539580558;9128;9188.586513606904;9316.8602470963;9421.670241541513;9509.952450237704;9291;9293.070692930653;9319.90680093204;9415.858762118574;9422.434653920787;7258.314423663279;7280.96359518199;7309.232530584319;7347.5224110432655;7359.932809742558;7085.0435191248525;7090.751823686146;7091.574505529685;7097.361237488651;7117.43060555144;8082.232187942136;8147.126345197101;8173.264406203471;8242.052164001216;8262.793430164294;8409.663613455394;8609.268212201783;8638.13618638131;8649.264812491008;8668.91331086681;6488.383603557654;6561.376669216417;6580.605163690194;6623.039659249478;6638.966805165944;7445.292697193758;7484.476086673881;7502.174760776419;7524.473286869867;7531;6857;6978.860422791618;6983.8254043647285;7077.716891324495;7112.217656057726;6315.747370105328;6476.384743449365;6867.656617169022;6879.58722476653;6980.371766540832;7000.22997470288;7018.473614478832;7081.256468070985;7084.929150708427;7086.893696594659;6400.775972840928;6412.807615771534;6417.03744438338;6428.6785660717715;6435.06691529735;6604.405603495708;6614.140161779131;6637.402633762985;6667.166604174478;6669.166354205724 07:59:38 INFO - 2015-11-11 07:59:38,231 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.01490550706154;333.16708229426433;334.49491268185034;336.784457946914;340.7887109991807;5870.735816888239;5872.823815285537;5879.941200587993;5907.0548712206055;5913.5564832637565;5736.282964629421;5742.052561327376;5746.569007324457;5762.9914764916075;5776.451237132476;4421.911561768763;4430.26900561407;4431.955680443202;4436.44544431946;4487.640988720911;4385.736855788647;4459.420275364214;4463.4643842738915;4471.754053527055;4484.97757511212;4354.02034542227;4393.406890069848;4393.868183954486;4403.361512580674;4408;4219.852305169335;4332.155229730204;4392.34114882767;4401.207782599131;4416.911661766762;3743.737938344317;3782.71629627779;3787.772733635991;3809;3826.330392181357;5419.674819510842;5431.83704488866;5441.59188060897;5443.2107344435235;5447.019536483432;4834.58905992991;4894.535019173173;5000.924986125211;5042.571381432583;5069.847904562869;6040.637561746309;6042.365551617061;6051.757929682852;6065.090236464522;6076.422739839708;4191.538930717618;4193.643540299078;4196.664266858644;4198.034452076009;4205.011822221775;6208.317085120633;6230.221222347207;6319.715612797435;6326.810195694091;6385.297617262097;4347.891302717458;4365.039691267916;4369.388285640013;4371.366151907955;4373.190959672471;4415.2494076006515;4417.1828211780285;4419.292913133883;4422.137683151755;4429.2913133899065;5104.719240441737;5112.105381558287;5116.462771409023;5116.795328186905;5122.87192820175;6099.3900609938655;6175.3515880832765;6212.378762123842;6223.564350495421;6227.532935029891;1573.7245981953113;1594.0913679202974;1597.4808187338929;1599.6640705451753;1601.1833964677865;1034.0280136671504;1042.8696412948382;1047.664747280863;1049.3861091261697;1052.3633201912885;5965.880682386415;5970.283565972111;5970.34326224115;5972.432618901197;5973.910391344133;6369.777057802955;6371.426571608577;6373.490120790326;6375.74497020114;6379.138816259839;5942.168096466498;5962.672053037125;5963.105534169822;5982.162497250389;5988.071848863433;3515.209077957439;3551.911202219965;3553.093961039918;3554.431290993429;3556.039869235292;6674.06563081169;6676.198856137197;6681.599104053772;6682.899756503656;6685.699143538553;6357.713902874381;6542.280349161589;6547.410733033955;6564.573302735403;6568.211814582281;6231.40801623845;6548.70530826114;6551.475881929434;6558.639274839834;6559.606423614503;6283.057541368831;6394.136791533084;6394.968025159845;6398.5521013528605;6402.871942561216;6336.08126821599;6343.746250150127;6347.111404403479;6348.555601107878;6349.174607301022;6539.6403197824575;6633.734650613921;6644.966775166094;6651;6661.633610151488;4300.3549467580115;4332.241857674957;4349.260625693576;4350.521442641244;4354;6332.715027823667;6346.1432706585865;6359.268684101387;6363.96818015907;6364.93635063662;6116;6174.9073763892675;6201.255849298113;6202.937970620236;6207.286162091236;6198.783042593487;6201.410865967726;6207.224096987877;6207.565470417027;6210.254769427697;6097.085437184458;6097.2988106366565;6099.75600975956;6100.420460056288;6103.664298463449;6153.13856060143;6239.1577137087725;6248.593841400295;6254.343293954252;6270.905936410866;6055;6091.0558863376245;6093.055576385667;6095.725692343766;6120.663363515049 07:59:38 INFO - 2015-11-11 07:59:38,232 DEBUG : BROWSER_OUTPUT: |5;yui.html;769.6536558548654;786.7167819584945;795.1372760554798;853.5007020892778;869.0353707384802;13679.589612311634;13894.305284735774;14045.227512486821;14051;14117.364718587662;12925.806112908314;13118.868811311884;13205.801912971314;13304;13315.067945243813;829.7427797382801;844.252836239926;846.6486408140614;847.3390755210914;847.3602430165216;695.2074634916174;705.4391758551964;822.0751654388813;828.4904783558129;829.1501211258447;885.5262434597491;887.0331338840663;894.472261365794;894.5661354243186;895.9776005599847;885.1856292211116;886.6276164011131;886.6940905387631;887.6671248281895;887.9112088791134;523.6910222968429;530.5357811914574;636.9777057802954;651.3258777165659;651.9771807986746;12946.287954162517;12995.285259310735;13059.869401305961;13090.280034598094;13093.607191784262;11945.402729863472;12939.67650808728;13023.739525209538;13129.671758206026;13198.878095361906;10494.212934029978;10629.255952083357;10645.84031239532;10686.625968091079;10871.510782014828;3599.190182209008;3654.926901461956;3681.7790932543867;3720.5907350191455;3768.1710023794994;47289.527104728855;47401.76299118482;47490.525094748955;47796.06956991251;47829;9344.953275233716;9347.719568412958;9754.365966212174;9821.459819709842;9846.261530385249;19017.14422850975;19246.326378576683;19255.422337329903;19258.22967081329;19269.710954335696;7676.19399963007;7793.2596403341595;7872.134065252818;7942.245486678757;8120.6345714443;4284.404766649399;4355.586219309161;4386.934195987063;4406.383106365111;4491.393661855673;3146.166265939528;3162.367526494664;3165.920851978719;3166.699163579456;3187.474066779002;486.39443892354245;490.443346801383;499.86003918902765;500.7746514068684;507.82733870484213;675.8884784010681;706.8409607838298;719.2771264878763;727.436236916394;730.2916171313817;8732.170443807829;9119.407238529475;9263;9363.344565880323;9445.811083778286;682.5733916302311;684.1277371351566;691.7544271783445;692.8371832619331;757.954522728638;4031.5162180537936;4193.287141186006;4394.516603173648;4423.20382331177;4442.6890117691455;55042.17436738452;55320;56773.43226567764;56993.43006569964;57179;50197.49802502001;50339.496605033484;50822.49177508252;51213.74393128085;51245.743771280904;44971.100577988254;45498.31752523715;45539;45569.54430455653;47556;8413.87379189325;8559.315254779478;8718.433301835614;8799.384043117176;8848.336374772047;33814.66185338115;34261.82869085739;34296.14259643529;34796.304073917876;34986.82506587451;40121.39817902792;40784.1843163141;43194.784026079666;45462.31806522971;46187;8093.635786389745;8230;8425.95787021061;8516.276116530164;8567.143285671384;12478.5008599655;12593.496260149492;12595.181313214613;12711.734099172365;13084.934575327063;11516.30902145874;11594.71013224676;11706.239094458833;11732.413379330828;11825.704357391134;11761.893854136622;11929;11958.521659133537;12016.699582510508;12154.270743755404;11713.88286117162;11787.941060294643;12031.45858436355;12122.484689413823;12357.814632780335;10143.64497242593;10216.846747298649;10289.073983341535;10294.897051029393;10638.84041739359;10208.54061567246;10370.740731481774;10387.480625968521;10476.63331783384;10519.579216831242 07:59:38 INFO - 2015-11-11 07:59:38,232 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,826 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: __startTimestamp1447257578222__endTimestamp 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5356.96 Median:5584.92 stddev:596.01 (10.7%) stddev-sans-first:572.26 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: Values: 3154.8 3184.8 3226.1 3227.0 3248.2 5186.5 5273.0 5304.1 5307.1 5341.3 5261.1 5309.2 5311.6 5317.3 5319.9 4678.9 4820.0 4836.7 4839.8 4921.3 4760.6 4978.2 4993.6 5015.6 5082.5 4777.1 4880.3 4887.8 4924.8 4931.9 4855.8 4856.3 4870.7 4884.7 4892.6 4775.1 4840.9 4841.4 4843.8 4889.8 5089.4 5121.6 5195.8 5202.7 5238.6 5861.4 5863.5 5866.0 5879.4 5886.1 5761.0 5874.2 5886.9 5899.2 5911.4 5375.4 5438.4 5444.5 5448.9 5490.2 5872.3 5878.4 5905.6 5914.4 5923.7 5584.9 5641.7 5709.7 5729.7 5732.2 5666.6 5668.5 5670.2 5670.4 5725.2 5664.8 5667.0 5671.4 5671.5 5681.7 5630.8 5691.3 5728.4 5772.5 5884.5 4471.2 4494.2 4499.9 4504.1 4534.5 4007.4 4008.8 4013.9 4046.2 4059.1 5306.8 5377.9 5412.2 5441.7 5472.3 5781.1 5824.8 5825.9 5826.7 5829.2 5319.3 5478.4 5483.6 5485.3 5489.9 4992.8 5014.8 5068.8 5091.0 5129.3 5994.9 6004.0 6019.3 6019.8 6019.8 5623.4 5787.0 5791.5 5795.9 5809.0 5905.1 5986.3 5999.6 6000.5 6037.6 5648.2 5650.6 5651.4 5680.1 5786.3 5694.5 5735.3 5741.5 5749.3 5821.7 5640.2 5660.4 5666.7 5668.3 5672.8 5628.2 5635.5 5647.2 5648.5 5651.7 5408.4 5439.4 5516.1 5547.9 5562.1 5583.9 5711.5 5754.1 5774.2 5817.7 5579.5 5597.1 5623.7 5634.5 5641.9 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46754.89 Median:182593.67 stddev:77069.01 (42.2%) stddev-sans-first:77207.10 07:59:38 INFO - 2015-11-11 07:59:38,233 DEBUG : BROWSER_OUTPUT: Values: 541.6 578.2 586.3 587.6 595.2 29406.0 30141.0 30174.8 39005.6 39844.0 42837.0 43176.0 43188.9 43291.8 43359.6 7647.2 8653.6 8779.5 8801.8 8825.5 7753.9 10396.4 10645.6 10671.0 10679.9 10335.8 10456.3 10465.1 10467.4 10470.0 7871.5 8061.5 10306.9 10416.0 10494.0 10253.8 10394.8 10410.5 10411.9 10413.5 39227.6 39668.6 39681.2 39696.4 39715.2 2770.9 2908.1 3184.4 3231.8 3276.8 28423.9 28744.9 29255.9 29259.6 30030.2 3239.8 3246.2 3288.8 3326.3 3347.6 247350.0 248223.0 248849.0 248964.0 250000.0 55097.4 55100.0 55292.2 55541.2 55661.2 57409.7 57482.7 57537.1 57618.1 57659.0 14789.9 15122.3 15155.4 15170.5 15172.2 12145.6 12206.6 12249.7 12293.7 12303.1 18847.2 18939.2 18945.0 19105.3 19187.8 7415.6 7475.1 7538.1 7546.8 7572.0 902.5 915.3 946.4 955.6 1095.9 28041.4 28239.6 28241.9 28415.6 28653.1 903.9 976.8 1031.1 1079.5 1113.5 13532.8 13851.9 14127.1 14132.7 14139.6 326218.0 330108.0 332039.0 332294.0 332410.0 43784.8 44824.8 52238.5 53321.0 53365.2 1330.5 1346.7 1349.4 1358.5 1364.3 23925.6 28326.7 28855.0 29857.0 30659.8 50290.2 50945.2 50953.0 50984.0 51014.2 297378.0 300265.0 301062.0 301327.0 301680.0 40619.8 41229.6 42540.8 42650.8 42678.6 44617.6 45157.0 45284.3 45443.8 45938.8 36935.3 37875.2 38549.0 38571.4 38876.8 38367.0 39784.4 40967.4 41734.6 42366.6 36317.5 36716.3 36750.1 36852.6 36875.1 29949.4 33148.3 33229.8 33567.7 33689.7 25393.2 25416.4 25813.9 25899.2 26013.5 07:59:38 INFO - 2015-11-11 07:59:38,234 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,234 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26270.48 Median:4556.88 stddev:84435.44 (1852.9%) stddev-sans-first:84649.88 07:59:38 INFO - 2015-11-11 07:59:38,234 DEBUG : BROWSER_OUTPUT: Values: 351.8 352.8 356.8 357.1 357.8 14044.7 14533.4 16473.3 17182.9 18121.5 11301.4 11743.1 16580.6 17725.7 17727.8 4451.2 4529.0 4547.8 4555.3 4567.7 3386.1 3502.6 4520.5 4558.5 4903.0 4899.4 4919.1 4937.9 4964.3 4980.9 4843.6 4851.7 4893.7 4924.2 4991.5 4225.5 4242.0 4255.1 4259.1 4264.4 13506.1 13931.5 13973.4 13985.2 13997.0 1677.6 1967.7 1981.1 1996.8 2123.0 9722.8 9855.0 9898.5 9965.2 9982.6 1674.7 1675.2 1679.1 1686.8 1753.7 61509.0 61657.7 63705.0 64402.4 64726.0 6751.0 6771.4 6772.4 6817.4 6830.9 8081.2 8142.2 8147.1 8147.9 8158.6 5229.8 5270.6 5277.4 5299.8 5311.3 5250.6 5281.9 5303.5 5325.4 5326.6 3158.6 3196.2 3202.3 3217.1 3220.3 1082.5 1089.8 1103.6 1129.7 1164.6 455.9 458.3 474.7 482.2 509.7 10910.2 11303.8 11315.9 11408.7 11899.8 441.7 493.7 501.6 503.2 504.9 5835.1 6155.6 6175.7 6259.7 6317.6 488929.0 492189.0 526222.0 526309.0 537567.0 71278.0 71596.6 75694.0 76647.9 77017.6 559.9 572.6 573.4 573.7 573.8 10902.7 11092.8 11291.8 11308.2 11343.7 35145.8 35438.0 36022.1 36151.5 36264.0 46962.5 48094.5 48883.0 49116.8 49483.0 6520.2 6663.5 6773.3 6797.2 6797.5 12038.9 12219.9 12260.8 12321.8 12359.8 8796.0 10803.7 10882.2 10968.8 11048.4 10150.2 10468.4 10495.4 10793.6 11092.4 8871.9 8887.2 11369.2 11463.9 11476.2 6615.4 6675.2 6693.4 6701.8 6706.2 10337.2 10575.8 10691.8 10698.5 11178.4 07:59:38 INFO - 2015-11-11 07:59:38,234 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,234 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5392.08 Median:6431.87 stddev:2784.23 (43.3%) stddev-sans-first:2776.64 07:59:38 INFO - 2015-11-11 07:59:38,235 DEBUG : BROWSER_OUTPUT: Values: 1496.0 1675.8 1750.6 1763.1 1765.5 6966.9 7577.1 7688.5 7727.7 7730.9 7537.4 7578.3 7600.2 7654.5 7659.7 1990.1 2037.4 2224.5 2267.3 2305.8 2275.0 2278.3 2279.6 2281.7 2282.3 2206.7 2290.9 2292.1 2292.5 2296.3 1999.3 2056.8 2210.6 2269.5 2271.1 2223.0 2225.9 2258.4 2261.1 2268.6 7616.1 7704.1 7726.8 7740.0 7742.2 4549.8 4616.6 4624.5 4642.2 4646.1 3064.4 3147.8 3169.1 3186.3 3187.0 944.5 961.4 976.8 989.1 1014.9 10485.3 10517.1 10618.9 10628.2 10635.8 4066.3 4131.1 4152.2 4160.1 4237.2 8661.0 8687.6 8694.8 8698.5 8703.5 4566.0 4569.5 4598.1 4606.8 4611.2 4196.8 4227.3 4231.0 4232.9 4236.8 3420.7 3474.8 3475.2 3480.6 3516.6 1050.6 1064.4 1067.5 1068.1 1072.6 1109.4 1296.1 1304.3 1340.4 1344.0 7320.5 7374.2 7395.8 7401.4 7409.1 1168.6 1174.6 1179.5 1210.2 1213.1 5318.6 5327.4 5334.8 5369.9 5374.1 9128.0 9188.6 9316.9 9421.7 9510.0 9291.0 9293.1 9319.9 9415.9 9422.4 7258.3 7281.0 7309.2 7347.5 7359.9 7085.0 7090.8 7091.6 7097.4 7117.4 8082.2 8147.1 8173.3 8242.1 8262.8 8409.7 8609.3 8638.1 8649.3 8668.9 6488.4 6561.4 6580.6 6623.0 6639.0 7445.3 7484.5 7502.2 7524.5 7531.0 6857.0 6978.9 6983.8 7077.7 7112.2 6315.7 6476.4 6867.7 6879.6 6980.4 7000.2 7018.5 7081.3 7084.9 7086.9 6400.8 6412.8 6417.0 6428.7 6435.1 6604.4 6614.1 6637.4 6667.2 6669.2 07:59:38 INFO - 2015-11-11 07:59:38,236 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,236 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5152.03 Median:5952.42 stddev:1557.48 (26.2%) stddev-sans-first:1519.22 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: Values: 330.0 333.2 334.5 336.8 340.8 5870.7 5872.8 5879.9 5907.1 5913.6 5736.3 5742.1 5746.6 5763.0 5776.5 4421.9 4430.3 4432.0 4436.4 4487.6 4385.7 4459.4 4463.5 4471.8 4485.0 4354.0 4393.4 4393.9 4403.4 4408.0 4219.9 4332.2 4392.3 4401.2 4416.9 3743.7 3782.7 3787.8 3809.0 3826.3 5419.7 5431.8 5441.6 5443.2 5447.0 4834.6 4894.5 5000.9 5042.6 5069.8 6040.6 6042.4 6051.8 6065.1 6076.4 4191.5 4193.6 4196.7 4198.0 4205.0 6208.3 6230.2 6319.7 6326.8 6385.3 4347.9 4365.0 4369.4 4371.4 4373.2 4415.2 4417.2 4419.3 4422.1 4429.3 5104.7 5112.1 5116.5 5116.8 5122.9 6099.4 6175.4 6212.4 6223.6 6227.5 1573.7 1594.1 1597.5 1599.7 1601.2 1034.0 1042.9 1047.7 1049.4 1052.4 5965.9 5970.3 5970.3 5972.4 5973.9 6369.8 6371.4 6373.5 6375.7 6379.1 5942.2 5962.7 5963.1 5982.2 5988.1 3515.2 3551.9 3553.1 3554.4 3556.0 6674.1 6676.2 6681.6 6682.9 6685.7 6357.7 6542.3 6547.4 6564.6 6568.2 6231.4 6548.7 6551.5 6558.6 6559.6 6283.1 6394.1 6395.0 6398.6 6402.9 6336.1 6343.7 6347.1 6348.6 6349.2 6539.6 6633.7 6645.0 6651.0 6661.6 4300.4 4332.2 4349.3 4350.5 4354.0 6332.7 6346.1 6359.3 6364.0 6364.9 6116.0 6174.9 6201.3 6202.9 6207.3 6198.8 6201.4 6207.2 6207.6 6210.3 6097.1 6097.3 6099.8 6100.4 6103.7 6153.1 6239.2 6248.6 6254.3 6270.9 6055.0 6091.1 6093.1 6095.7 6120.7 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13775.20 Median:45518.66 stddev:15647.24 (34.4%) stddev-sans-first:15660.65 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: Values: 769.7 786.7 795.1 853.5 869.0 13679.6 13894.3 14045.2 14051.0 14117.4 12925.8 13118.9 13205.8 13304.0 13315.1 829.7 844.3 846.6 847.3 847.4 695.2 705.4 822.1 828.5 829.2 885.5 887.0 894.5 894.6 896.0 885.2 886.6 886.7 887.7 887.9 523.7 530.5 637.0 651.3 652.0 12946.3 12995.3 13059.9 13090.3 13093.6 11945.4 12939.7 13023.7 13129.7 13198.9 10494.2 10629.3 10645.8 10686.6 10871.5 3599.2 3654.9 3681.8 3720.6 3768.2 47289.5 47401.8 47490.5 47796.1 47829.0 9345.0 9347.7 9754.4 9821.5 9846.3 19017.1 19246.3 19255.4 19258.2 19269.7 7676.2 7793.3 7872.1 7942.2 8120.6 4284.4 4355.6 4386.9 4406.4 4491.4 3146.2 3162.4 3165.9 3166.7 3187.5 486.4 490.4 499.9 500.8 507.8 675.9 706.8 719.3 727.4 730.3 8732.2 9119.4 9263.0 9363.3 9445.8 682.6 684.1 691.8 692.8 758.0 4031.5 4193.3 4394.5 4423.2 4442.7 55042.2 55320.0 56773.4 56993.4 57179.0 50197.5 50339.5 50822.5 51213.7 51245.7 44971.1 45498.3 45539.0 45569.5 47556.0 8413.9 8559.3 8718.4 8799.4 8848.3 33814.7 34261.8 34296.1 34796.3 34986.8 40121.4 40784.2 43194.8 45462.3 46187.0 8093.6 8230.0 8426.0 8516.3 8567.1 12478.5 12593.5 12595.2 12711.7 13084.9 11516.3 11594.7 11706.2 11732.4 11825.7 11761.9 11929.0 11958.5 12016.7 12154.3 11713.9 11787.9 12031.5 12122.5 12357.8 10143.6 10216.8 10289.1 10294.9 10638.8 10208.5 10370.7 10387.5 10476.6 10519.6 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:59:38 INFO - 2015-11-11 07:59:38,237 DEBUG : BROWSER_OUTPUT: 07:59:38 INFO - 2015-11-11 07:59:38,937 INFO : Browser exited with error code: 0 07:59:38 INFO - 2015-11-11 07:59:38,956 INFO : Completed test dromaeo_css (00:18:31) 07:59:38 INFO - 2015-11-11 07:59:38,956 INFO : Starting test kraken 07:59:38 INFO - 2015-11-11 07:59:38,956 DEBUG : operating with platform_type : linux_ 07:59:38 INFO - 2015-11-11 07:59:38,956 INFO : Initialising browser for kraken test... 07:59:38 INFO - 2015-11-11 07:59:38,962 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDJTp1J/profile http://localhost:35148/getInfo.html 07:59:42 INFO - 2015-11-11 07:59:42,683 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:59:42 INFO - 2015-11-11 07:59:42,683 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:59:42 INFO - 2015-11-11 07:59:42,683 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:59:42 INFO - 2015-11-11 07:59:42,683 DEBUG : BROWSER_OUTPUT: __metrics 07:59:42 INFO - 2015-11-11 07:59:42,800 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:43 INFO - 2015-11-11 07:59:43,967 INFO : Browser initialized. 07:59:43 INFO - 2015-11-11 07:59:43,968 INFO : Running cycle 1/1 for kraken test... 07:59:43 INFO - 2015-11-11 07:59:43,968 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDJTp1J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:59:55 INFO - 2015-11-11 07:59:55,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 07:59:55 INFO - 2015-11-11 07:59:55,687 DEBUG : BROWSER_OUTPUT: 07:59:58 INFO - 2015-11-11 07:59:58,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35148/tests/kraken/driver.html?testName=audio-beat-detection) 07:59:58 INFO - 2015-11-11 07:59:58,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 179625984 07:59:58 INFO - 2015-11-11 07:59:58,729 DEBUG : BROWSER_OUTPUT: 08:00:01 INFO - 2015-11-11 08:00:01,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35148/tests/kraken/driver.html?testName=audio-dft) 08:00:01 INFO - 2015-11-11 08:00:01,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 168665088 08:00:01 INFO - 2015-11-11 08:00:01,876 DEBUG : BROWSER_OUTPUT: 08:00:04 INFO - 2015-11-11 08:00:04,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35148/tests/kraken/driver.html?testName=audio-fft) 08:00:05 INFO - 2015-11-11 08:00:05,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 151773184 08:00:05 INFO - 2015-11-11 08:00:05,323 DEBUG : BROWSER_OUTPUT: 08:00:07 INFO - 2015-11-11 08:00:07,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35148/tests/kraken/driver.html?testName=audio-oscillator) 08:00:07 INFO - 2015-11-11 08:00:07,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 152780800 08:00:07 INFO - 2015-11-11 08:00:07,841 DEBUG : BROWSER_OUTPUT: 08:00:09 INFO - 2015-11-11 08:00:09,980 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:00:10 INFO - 2015-11-11 08:00:10,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 154980352 08:00:10 INFO - 2015-11-11 08:00:10,540 DEBUG : BROWSER_OUTPUT: 08:00:13 INFO - 2015-11-11 08:00:13,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35148/tests/kraken/driver.html?testName=imaging-darkroom) 08:00:14 INFO - 2015-11-11 08:00:14,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 154877952 08:00:14 INFO - 2015-11-11 08:00:14,036 DEBUG : BROWSER_OUTPUT: 08:00:17 INFO - 2015-11-11 08:00:17,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35148/tests/kraken/driver.html?testName=imaging-desaturate) 08:00:18 INFO - 2015-11-11 08:00:18,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 156061696 08:00:18 INFO - 2015-11-11 08:00:18,026 DEBUG : BROWSER_OUTPUT: 08:00:20 INFO - 2015-11-11 08:00:20,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35148/tests/kraken/driver.html?testName=json-parse-financial) 08:00:21 INFO - 2015-11-11 08:00:21,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 156213248 08:00:21 INFO - 2015-11-11 08:00:21,321 DEBUG : BROWSER_OUTPUT: 08:00:22 INFO - 2015-11-11 08:00:22,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:23 INFO - 2015-11-11 08:00:23,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 162775040 08:00:23 INFO - 2015-11-11 08:00:23,453 DEBUG : BROWSER_OUTPUT: 08:00:25 INFO - 2015-11-11 08:00:25,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:25 INFO - 2015-11-11 08:00:25,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 162701312 08:00:25 INFO - 2015-11-11 08:00:25,846 DEBUG : BROWSER_OUTPUT: 08:00:27 INFO - 2015-11-11 08:00:27,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:00:28 INFO - 2015-11-11 08:00:28,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 176152576 08:00:28 INFO - 2015-11-11 08:00:28,479 DEBUG : BROWSER_OUTPUT: 08:00:30 INFO - 2015-11-11 08:00:30,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:00:31 INFO - 2015-11-11 08:00:31,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 178470912 08:00:31 INFO - 2015-11-11 08:00:31,499 DEBUG : BROWSER_OUTPUT: 08:00:34 INFO - 2015-11-11 08:00:34,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:00:34 INFO - 2015-11-11 08:00:34,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 178634752 08:00:34 INFO - 2015-11-11 08:00:34,603 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35148/tests/kraken/driver.html?testName=ai-astar) 08:00:36 INFO - 2015-11-11 08:00:36,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 236281856 08:00:36 INFO - 2015-11-11 08:00:36,505 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:00:36 INFO - 2015-11-11 08:00:36,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:00:36 INFO - 2015-11-11 08:00:36,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:00:36 INFO - 2015-11-11 08:00:36,507 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:00:36 INFO - 2015-11-11 08:00:36,508 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;104;110;110;110;100;110;113;109 08:00:36 INFO - 2015-11-11 08:00:36,508 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;126;151;164;127;153;149;125;164;125 08:00:36 INFO - 2015-11-11 08:00:36,508 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;161;160;160;160;160;164;161;161 08:00:36 INFO - 2015-11-11 08:00:36,508 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;85;95;71;71;72;120;87;72 08:00:36 INFO - 2015-11-11 08:00:36,508 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;89;91;91;135;90;90;137 08:00:36 INFO - 2015-11-11 08:00:36,509 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;110;111;110;110 08:00:36 INFO - 2015-11-11 08:00:36,509 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;145;145;145;145;145;146 08:00:36 INFO - 2015-11-11 08:00:36,509 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;97;95;95;95;95 08:00:36 INFO - 2015-11-11 08:00:36,510 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;58;57;58;58;60;72;56;56 08:00:36 INFO - 2015-11-11 08:00:36,510 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;67;68;68;69;68;67;67 08:00:36 INFO - 2015-11-11 08:00:36,510 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;85;84;84;84;85;84;92 08:00:36 INFO - 2015-11-11 08:00:36,511 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;115;115;119;123;122;131;118;121;137 08:00:36 INFO - 2015-11-11 08:00:36,512 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;149;147;150;141;142;154;154;148;142 08:00:36 INFO - 2015-11-11 08:00:36,512 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;67;68;67;70;67;67;67;69 08:00:36 INFO - 2015-11-11 08:00:36,512 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:00:36 INFO - 2015-11-11 08:00:36,512 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:00:36 INFO - 2015-11-11 08:00:36,512 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 08:00:36 INFO - 2015-11-11 08:00:36,513 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:00:36 INFO - 2015-11-11 08:00:36,513 DEBUG : BROWSER_OUTPUT: __startTimestamp1447257636506__endTimestamp 08:00:36 INFO - 2015-11-11 08:00:36,513 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,514 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:00:36 INFO - 2015-11-11 08:00:36,514 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:00:36 INFO - 2015-11-11 08:00:36,514 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:4.09 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 104.0 110.0 110.0 110.0 100.0 110.0 113.0 109.0 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.00 stddev:15.95 (10.6%) stddev-sans-first:16.86 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: Values: 147.0 126.0 151.0 164.0 127.0 153.0 149.0 125.0 164.0 125.0 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 161.0 160.0 160.0 160.0 160.0 164.0 161.0 161.0 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,515 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:72.00 stddev:16.16 (22.4%) stddev-sans-first:16.61 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 85.0 95.0 71.0 71.0 72.0 120.0 87.0 72.0 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:90.00 stddev:22.00 (24.4%) stddev-sans-first:22.77 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 89.0 91.0 91.0 135.0 90.0 90.0 137.0 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,516 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.00 stddev:4.66 (8.0%) stddev-sans-first:4.94 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 58.0 57.0 58.0 58.0 60.0 72.0 56.0 56.0 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 67.0 68.0 68.0 69.0 68.0 67.0 67.0 08:00:36 INFO - 2015-11-11 08:00:36,517 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.56 (3.0%) stddev-sans-first:2.69 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 85.0 84.0 84.0 84.0 85.0 84.0 92.0 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:122.00 stddev:6.91 (5.7%) stddev-sans-first:7.33 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: Values: 122.0 115.0 115.0 119.0 123.0 122.0 131.0 118.0 121.0 137.0 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:148.50 stddev:4.73 (3.2%) stddev-sans-first:4.95 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: Values: 145.0 149.0 147.0 150.0 141.0 142.0 154.0 154.0 148.0 142.0 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.24 08:00:36 INFO - 2015-11-11 08:00:36,518 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 67.0 68.0 67.0 70.0 67.0 67.0 67.0 69.0 08:00:36 INFO - 2015-11-11 08:00:36,519 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:00:36 INFO - 2015-11-11 08:00:36,519 DEBUG : BROWSER_OUTPUT: 08:00:37 INFO - 2015-11-11 08:00:37,313 INFO : Browser exited with error code: 0 08:00:37 INFO - 2015-11-11 08:00:37,367 INFO : Completed test kraken (00:00:58) 08:00:37 INFO - 2015-11-11 08:00:37,367 INFO : Starting test v8_7 08:00:37 INFO - 2015-11-11 08:00:37,367 DEBUG : operating with platform_type : linux_ 08:00:37 INFO - 2015-11-11 08:00:37,367 INFO : Initialising browser for v8_7 test... 08:00:37 INFO - 2015-11-11 08:00:37,373 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1ux6Ij/profile http://localhost:35148/getInfo.html 08:00:41 INFO - 2015-11-11 08:00:41,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:00:41 INFO - 2015-11-11 08:00:41,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:00:41 INFO - 2015-11-11 08:00:41,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:00:41 INFO - 2015-11-11 08:00:41,112 DEBUG : BROWSER_OUTPUT: __metrics 08:00:41 INFO - 2015-11-11 08:00:41,270 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:42 INFO - 2015-11-11 08:00:42,379 INFO : Browser initialized. 08:00:42 INFO - 2015-11-11 08:00:42,380 INFO : Running cycle 1/1 for v8_7 test... 08:00:42 INFO - 2015-11-11 08:00:42,380 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1ux6Ij/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:00:54 INFO - 2015-11-11 08:00:54,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 08:00:54 INFO - 2015-11-11 08:00:54,143 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35148/tests/v8_7/run.html (next: http://localhost:35148/tests/v8_7/run.html) 08:01:15 INFO - 2015-11-11 08:01:15,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 619167744 08:01:15 INFO - 2015-11-11 08:01:15,811 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,811 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: |0;Richards;163.31863465621427 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.89928598271325 08:01:15 INFO - 2015-11-11 08:01:15,812 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.8489289740699 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1100.1100110011 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |6;Boyer;11697.67441860465 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |7;RegExp;25717.94871794872 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |8;Splay;638.1620931716656 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 08:01:15 INFO - 2015-11-11 08:01:15,813 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: __startTimestamp1447257675808__endTimestamp 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.32 Median:163.32 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: Values: 163.3 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: Values: 187.9 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.85 Median:281.85 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,814 DEBUG : BROWSER_OUTPUT: Values: 281.8 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: Values: 5040.2 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: Values: 1100.1 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: Values: 786.8 08:01:15 INFO - 2015-11-11 08:01:15,815 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11697.67 Median:11697.67 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: Values: 11697.7 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25717.95 Median:25717.95 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: Values: 25717.9 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:638.16 Median:638.16 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: Values: 638.2 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: Values: 4830.9 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:01:15 INFO - 2015-11-11 08:01:15,816 DEBUG : BROWSER_OUTPUT: 08:01:16 INFO - 2015-11-11 08:01:16,653 INFO : Browser exited with error code: 0 08:01:16 INFO - 2015-11-11 08:01:16,668 INFO : Completed test v8_7 (00:00:39) 08:01:16 INFO - 2015-11-11 08:01:16,792 INFO : Completed test suite (00:20:09) 08:01:16 INFO - 2015-11-11 08:01:16,793 DEBUG : Working with test: dromaeo_css 08:01:16 INFO - 2015-11-11 08:01:16,793 DEBUG : Generating results file: dromaeo_css 08:01:16 INFO - 2015-11-11 08:01:16,794 DEBUG : Working with test: kraken 08:01:16 INFO - 2015-11-11 08:01:16,794 DEBUG : Generating results file: kraken 08:01:16 INFO - 2015-11-11 08:01:16,794 INFO : javascript benchmark 08:01:16 INFO - 2015-11-11 08:01:16,794 DEBUG : Working with test: v8_7 08:01:16 INFO - 2015-11-11 08:01:16,795 DEBUG : Generating results file: v8_7 08:01:16 INFO - 2015-11-11 08:01:16,795 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:16 INFO - 2015-11-11 08:01:16,875 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:01:16 INFO - 2015-11-11 08:01:16,875 DEBUG : process_Request line: dromaeo_css 6692.87 graph.html#tests=[[72,64,35]] 08:01:16 INFO - 2015-11-11 08:01:16,875 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:16 INFO - 2015-11-11 08:01:16,911 DEBUG : process_Request line: kraken 1496.90 graph.html#tests=[[232,64,35]] 08:01:16 INFO - 2015-11-11 08:01:16,911 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:01:17 INFO - 2015-11-11 08:01:17,040 DEBUG : process_Request line: v8_7 21136.06 graph.html#tests=[[230,64,35]] 08:01:17 INFO - 2015-11-11 08:01:17,042 INFO : javascript benchmark 08:01:17 INFO - 2015-11-11 08:01:17,045 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [351.82408795602197, 352.7848012712246, 356.75383985050314, 357.05202686866363, 357.79426829573003, 14044.719105617882, 14533.418663253457, 16473.34106635733, 17182.91408542957, 18121.546961325956, 11301.378424186667, 11743.06055515559, 16580.585485362873, 17725.7341139883, 17727.82272177278, 4451.154280686667, 4529.0, 4547.840825571106, 4555.293929440925, 4567.680262381635, 3386.1365351835248, 3502.6322236165092, 4520.525344838794, 4558.475775285851, 4903.0, 4899.387576552931, 4919.065377578267, 4937.876553086166, 4964.304997300381, 4980.900381992358, 4843.636727245453, 4851.708897466128, 4893.657443978923, 4924.162892308298, 4991.500849914997, 4225.492940847087, 4242.045539753562, 4255.127698821734, 4259.1268789897995, 4264.424302719155, 13506.122102063335, 13931.512397066053, 13973.371198296, 13985.160890346611, 13997.020208585403, 1677.614148745783, 1967.7245185673873, 1981.0787983587702, 1996.7603887533444, 2123.0446299165437, 9722.75693107678, 9855.0, 9898.455584942825, 9965.15296199824, 9982.550785214682, 1674.673438679458, 1675.2293944785292, 1679.110071662021, 1686.7975842898932, 1753.6580366828473, 61509.0, 61657.69171154161, 63705.04442433321, 64402.35597644011, 64726.0, 6750.966245168743, 6771.3905748482875, 6772.356626120511, 6817.386435220854, 6830.897536536956, 8081.151479094728, 8142.185781421929, 8147.063087744867, 8147.918520814835, 8158.551279679675, 5229.790808367623, 5270.60470464709, 5277.445868183785, 5299.788008479694, 5311.256424100629, 5250.606204534675, 5281.943611277683, 5303.549198318109, 5325.440828712929, 5326.627136100513, 3158.6209654841105, 3196.2488815128427, 3202.279487115427, 3217.131374528864, 3220.339830334776, 1082.4858192358568, 1089.8256278995482, 1103.564092183583, 1129.7345123895877, 1164.5632887667125, 455.9452865656076, 458.3468557305826, 474.70331043098065, 482.2452861272098, 509.68144909431606, 10910.23628346024, 11303.773924521627, 11315.886841131483, 11408.657740267805, 11899.762004759856, 441.72612979952635, 493.6914428482199, 501.5636396335139, 503.2024241577068, 504.89649621827436, 5835.124731290341, 6155.599886007395, 6175.722092505848, 6259.71831267594, 6317.5893566918, 488929.0, 492189.0, 526222.0, 526309.0, 537567.0, 71278.0, 71596.64201679062, 75694.0, 76647.92694989913, 77017.61491192508, 559.9104143337128, 572.6020415810972, 573.3664300947477, 573.7217449536971, 573.8163787588015, 10902.672919812418, 11092.778144436905, 11291.830622540505, 11308.208425410143, 11343.659690209306, 35145.82427087848, 35438.0, 36022.09944751297, 36151.45772813463, 36264.0, 46962.530374697184, 48094.519054809, 48883.0, 49116.754416229116, 49483.01033979372, 6520.18497687789, 6663.5002374821115, 6773.288804675635, 6797.1843378794865, 6797.456203503609, 12038.879611203776, 12219.900208981235, 12260.816087758869, 12321.815172772594, 12359.814602781145, 8795.956020219857, 10803.729906752395, 10882.183836212158, 10968.835467468154, 11048.392338421463, 10150.187984961332, 10468.371897686164, 10495.370277783357, 10793.62222322215, 11092.445377730919, 8871.911280887109, 8887.200151986352, 11369.204155709022, 11463.942680286546, 11476.196666233283, 6615.437687796399, 6675.198976122896, 6693.431058359899, 6701.832454188684, 6706.228783689938, 10337.224708146769, 10575.841362379417, 10691.786164276515, 10698.465076746288, 11178.385188814693], "dojo.html": [3154.8107113573187, 3184.8248346340943, 3226.145071556037, 3226.983865080674, 3248.2204270974958, 5186.455422180673, 5272.973635131823, 5304.124819404794, 5307.097793375126, 5341.305630268064, 5261.1319132343115, 5309.177077552976, 5311.57507399408, 5317.308749862513, 5319.893602127965, 4678.883027924295, 4819.975900120495, 4836.733979631119, 4839.782209800559, 4921.335619691349, 4760.619150467955, 4978.153713868633, 4993.6254780891395, 5015.5736762375245, 5082.466341034194, 4777.06847164803, 4880.341153944208, 4887.804487820483, 4924.80300787968, 4931.876703082416, 4855.757212139379, 4856.2958371036, 4870.65905386623, 4884.731339776311, 4892.559669629715, 4775.14047471455, 4840.854774356775, 4841.443234028096, 4843.75781210938, 4889.755512224375, 5089.440161582223, 5121.641485096045, 5195.792168313263, 5202.661826981234, 5238.633295669267, 5861.3552509223955, 5863.5016023638045, 5866.032104702719, 5879.412058794129, 5886.05823068307, 5760.9711951440395, 5874.1776151338845, 5886.882262354772, 5899.203607512974, 5911.379305172938, 5375.408705042442, 5438.428964958702, 5444.50999410055, 5448.891022179534, 5490.176473529003, 5872.29532456108, 5878.382769809194, 5905.645661260338, 5914.378990206053, 5923.703814809242, 5584.91622625661, 5641.689707066151, 5709.65742055478, 5729.656220626775, 5732.197492351074, 5666.603337766317, 5668.546516278688, 5670.177824215548, 5670.404607516151, 5725.198472213893, 5664.830055098354, 5667.0, 5671.432856714296, 5671.546276297886, 5681.715914204273, 5630.8029218977135, 5691.26013618227, 5728.369879313273, 5772.480476757112, 5884.529237661062, 4471.150481408522, 4494.213512635276, 4499.887502812456, 4504.054148628825, 4534.455865296186, 4007.3988901664984, 4008.819603117867, 4013.8795836124964, 4046.1503084352616, 4059.1475790084414, 5306.787728490817, 5377.892442151213, 5412.215228791882, 5441.673499590037, 5472.288602481732, 5781.075027995585, 5824.796132135355, 5825.912611310834, 5826.65040097587, 5829.154772557956, 5319.308489896289, 5478.397376288684, 5483.561315094783, 5485.341758988947, 5489.862753431196, 4992.775325110379, 5014.824481143142, 5068.847934561969, 5090.974545127251, 5129.333186685707, 5994.850128746816, 6004.039353703386, 6019.307779605314, 6019.759209631566, 6019.849503762441, 5623.353314368736, 5786.987277226553, 5791.507721843522, 5795.8551036224435, 5808.970955145366, 5905.084711869667, 5986.3115741688525, 5999.610025348338, 6000.459958603747, 6037.607555508878, 5648.15277708347, 5650.576206784425, 5651.4348565143155, 5680.062789639664, 5786.334571524329, 5694.4590263924865, 5735.254416925773, 5741.45456181662, 5749.310082790092, 5821.650700957956, 5640.153976903333, 5660.405657405913, 5666.688332141772, 5668.26312579362, 5672.7730890763905, 5628.212050312877, 5635.520980716685, 5647.181158731879, 5648.548116150616, 5651.745671444713, 5408.405075441619, 5439.401665816836, 5516.117421212587, 5547.944520554743, 5562.054450743302, 5583.888322233452, 5711.485966263056, 5754.108113242454, 5774.1916131740745, 5817.680027598522, 5579.525740311957, 5597.076482380525, 5623.746931388016, 5634.464725851038, 5641.8589535261945], "mootools.html": [1495.9925200373996, 1675.7989041315045, 1750.6323672028873, 1763.1448747357529, 1765.5409593505685, 6966.895496567556, 7577.052868391451, 7688.500247483909, 7727.652255648495, 7730.884036739453, 7537.359324457414, 7578.317951384374, 7600.20197879223, 7654.54072755635, 7659.731909383173, 1990.144237977669, 2037.368415791102, 2224.477247846755, 2267.308470916374, 2305.8155347572238, 2275.0444813178506, 2278.293728944024, 2279.5782780185637, 2281.7261928568596, 2282.2924893283052, 2206.680031395447, 2290.942726431836, 2292.1175347491253, 2292.5300313435787, 2296.3111066680012, 1999.3002449142757, 2056.8148866602005, 2210.635245184543, 2269.47802005538, 2271.0802125139344, 2222.9888850555644, 2225.9109635614554, 2258.4015235962484, 2261.1068627892055, 2268.6370180770996, 7616.086069671619, 7704.114026886924, 7726.845463090706, 7739.961300193463, 7742.225777422269, 4549.840755573539, 4616.584507394351, 4624.537546245382, 4642.210824159867, 4646.140464014168, 3064.4024415239037, 3147.763917706181, 3169.0809665197066, 3186.2990142168687, 3187.043886833964, 944.4569372610777, 961.4135377419768, 976.8437050072025, 989.0653332600696, 1014.8985101489866, 10485.318454300523, 10517.1060459861, 10618.946905265502, 10628.202884783672, 10635.840462393071, 4066.268071747055, 4131.132462182975, 4152.211079894811, 4160.1471698301775, 4237.194932962727, 8661.0, 8687.565621718888, 8694.782630434163, 8698.521581313089, 8703.521306328086, 4566.0, 4569.451665800125, 4598.1033698429155, 4606.769661516911, 4611.1930412177735, 4196.81114349855, 4227.3447615619625, 4230.957690423118, 4232.8518501852905, 4236.766977816188, 3420.7263418926427, 3474.8436320365645, 3475.2180759329453, 3480.582330120402, 3516.5955915070094, 1050.6270274052602, 1064.4411683866033, 1067.4716015572342, 1068.1134658233648, 1072.5709716113618, 1109.417555783204, 1296.0603562417361, 1304.315234501894, 1340.3633274194874, 1344.0188662276594, 7320.524165929198, 7374.225706300868, 7395.8151046224275, 7401.370883474858, 7409.073865766779, 1168.6143572621015, 1174.618249069056, 1179.4869231883986, 1210.2466887830258, 1213.071999920062, 5318.574514038945, 5327.360716714019, 5334.813281535127, 5369.892602147936, 5374.059539580558, 9128.0, 9188.586513606904, 9316.8602470963, 9421.670241541513, 9509.952450237704, 9291.0, 9293.070692930653, 9319.90680093204, 9415.858762118574, 9422.434653920787, 7258.314423663279, 7280.96359518199, 7309.232530584319, 7347.5224110432655, 7359.932809742558, 7085.0435191248525, 7090.751823686146, 7091.574505529685, 7097.361237488651, 7117.43060555144, 8082.232187942136, 8147.126345197101, 8173.264406203471, 8242.052164001216, 8262.793430164294, 8409.663613455394, 8609.268212201783, 8638.13618638131, 8649.264812491008, 8668.91331086681, 6488.383603557654, 6561.376669216417, 6580.605163690194, 6623.039659249478, 6638.966805165944, 7445.292697193758, 7484.476086673881, 7502.174760776419, 7524.473286869867, 7531.0, 6857.0, 6978.860422791618, 6983.8254043647285, 7077.716891324495, 7112.217656057726, 6315.747370105328, 6476.384743449365, 6867.656617169022, 6879.58722476653, 6980.371766540832, 7000.22997470288, 7018.473614478832, 7081.256468070985, 7084.929150708427, 7086.893696594659, 6400.775972840928, 6412.807615771534, 6417.03744438338, 6428.6785660717715, 6435.06691529735, 6604.405603495708, 6614.140161779131, 6637.402633762985, 6667.166604174478, 6669.166354205724], "ext.html": [541.5883928214556, 578.2396149063981, 586.2964442668798, 587.6268569458396, 595.2291782142125, 29406.0, 30141.0, 30174.84912575434, 39005.609943900556, 39844.0, 42837.0, 43176.0, 43188.92027699301, 43291.78354108225, 43359.56640433602, 7647.197044310351, 8653.61058752356, 8779.517126558037, 8801.823963520726, 8825.51459669718, 7753.922460775405, 10396.428196449193, 10645.574177032948, 10671.039606435419, 10679.946600267027, 10335.793284134314, 10456.268061235716, 10465.058144767008, 10467.371957682526, 10470.0, 7871.527708337518, 8061.476004059776, 10306.89693103067, 10416.0, 10494.0, 10253.795433981655, 10394.79210415795, 10410.479476026168, 10411.94794026025, 10413.531391087343, 39227.60772392296, 39668.60331396678, 39681.20637587232, 39696.404553931716, 39715.20569588621, 2770.8735161360887, 2908.0984894682715, 3184.379046086014, 3231.8222497762613, 3276.754243431752, 28423.85788071067, 28744.856275718488, 29255.853720731473, 29259.56110658342, 30030.249243768863, 3239.7732158748895, 3246.2046798534275, 3288.8355582220793, 3326.301476689898, 3347.598288205431, 247350.0, 248222.9999999982, 248849.0, 248964.0, 250000.0, 55097.44902551003, 55100.0, 55292.170617440774, 55541.16688249679, 55661.165082523796, 57409.71295143497, 57482.7125864368, 57537.13694294589, 57618.135727964116, 57659.0, 14789.852101478848, 15122.319495622723, 15155.393784248727, 15170.469033583771, 15172.165530895907, 12145.63563093091, 12206.633800985985, 12249.69375765613, 12293.692657683629, 12303.138780285473, 18847.246110155713, 18939.242430302635, 18945.0, 19105.331313403964, 19187.808121918883, 7415.629218539051, 7475.140358858692, 7538.09542854861, 7546.773596792105, 7572.0, 902.4900930973979, 915.2677857713802, 946.4179529589253, 955.6273053509137, 1095.8684957805115, 28041.43917121646, 28239.57640635392, 28241.881858860666, 28415.57376639352, 28653.14040578786, 903.8689390038408, 976.8095221431753, 1031.0565832263544, 1079.4818487126224, 1113.549012649878, 13532.797008044887, 13851.930740346234, 14127.081739687093, 14132.717345653235, 14139.64650883736, 326218.0, 330108.0, 332039.0, 332294.0, 332410.0, 43784.78107609505, 44824.77587612041, 52238.477615224125, 53321.0, 53365.19952200643, 1330.481112366178, 1346.7037251804588, 1349.406261245049, 1358.538097046989, 1364.290568904184, 23925.641115382936, 28326.716732833233, 28855.0, 29857.0, 30659.846700766353, 50290.24564631606, 50945.23582146345, 50953.0, 50984.0, 51014.23478647749, 297378.0, 300265.0, 301062.0, 301327.0, 301680.0, 40619.7969010153, 41229.587704122576, 42540.787296063325, 42650.78674606607, 42678.57321426746, 44617.55382446134, 45157.0, 45284.320735189656, 45443.772781135885, 45938.77030614825, 36935.261294773416, 37875.242495150495, 38549.0, 38571.421428679154, 38876.80561597174, 38367.0, 39784.40323395209, 40967.38548921709, 41734.58265417307, 42366.5763342375, 36317.45523817198, 36716.26567468689, 36750.081247969014, 36852.63147368492, 36875.12811154898, 29949.401011979204, 33148.33703325968, 33229.83385083059, 33567.664323356454, 33689.66310336865, 25393.180236604185, 25416.364590885376, 25813.870930645226, 25899.223023309332, 26013.479730405663], "prototype.html": [330.01490550706154, 333.16708229426433, 334.49491268185034, 336.784457946914, 340.7887109991807, 5870.735816888239, 5872.823815285537, 5879.941200587993, 5907.0548712206055, 5913.5564832637565, 5736.282964629421, 5742.052561327376, 5746.569007324457, 5762.9914764916075, 5776.451237132476, 4421.911561768763, 4430.26900561407, 4431.955680443202, 4436.44544431946, 4487.640988720911, 4385.736855788647, 4459.420275364214, 4463.4643842738915, 4471.754053527055, 4484.97757511212, 4354.02034542227, 4393.406890069848, 4393.868183954486, 4403.361512580674, 4408.0, 4219.852305169335, 4332.155229730204, 4392.34114882767, 4401.207782599131, 4416.911661766762, 3743.737938344317, 3782.71629627779, 3787.772733635991, 3809.0, 3826.330392181357, 5419.674819510842, 5431.83704488866, 5441.59188060897, 5443.2107344435235, 5447.019536483432, 4834.58905992991, 4894.535019173173, 5000.924986125211, 5042.571381432583, 5069.847904562869, 6040.637561746309, 6042.365551617061, 6051.757929682852, 6065.090236464522, 6076.422739839708, 4191.538930717618, 4193.643540299078, 4196.664266858644, 4198.034452076009, 4205.011822221775, 6208.317085120633, 6230.221222347207, 6319.715612797435, 6326.810195694091, 6385.297617262097, 4347.891302717458, 4365.039691267916, 4369.388285640013, 4371.366151907955, 4373.190959672471, 4415.2494076006515, 4417.1828211780285, 4419.292913133883, 4422.137683151755, 4429.2913133899065, 5104.719240441737, 5112.105381558287, 5116.462771409023, 5116.795328186905, 5122.87192820175, 6099.3900609938655, 6175.3515880832765, 6212.378762123842, 6223.564350495421, 6227.532935029891, 1573.7245981953113, 1594.0913679202974, 1597.4808187338929, 1599.6640705451753, 1601.1833964677865, 1034.0280136671504, 1042.8696412948382, 1047.664747280863, 1049.3861091261697, 1052.3633201912885, 5965.880682386415, 5970.283565972111, 5970.34326224115, 5972.432618901197, 5973.910391344133, 6369.777057802955, 6371.426571608577, 6373.490120790326, 6375.74497020114, 6379.138816259839, 5942.168096466498, 5962.672053037125, 5963.105534169822, 5982.162497250389, 5988.071848863433, 3515.209077957439, 3551.911202219965, 3553.093961039918, 3554.431290993429, 3556.039869235292, 6674.06563081169, 6676.198856137197, 6681.599104053772, 6682.899756503656, 6685.699143538553, 6357.713902874381, 6542.280349161589, 6547.410733033955, 6564.573302735403, 6568.211814582281, 6231.40801623845, 6548.70530826114, 6551.475881929434, 6558.639274839834, 6559.606423614503, 6283.057541368831, 6394.136791533084, 6394.968025159845, 6398.5521013528605, 6402.871942561216, 6336.08126821599, 6343.746250150127, 6347.111404403479, 6348.555601107878, 6349.174607301022, 6539.6403197824575, 6633.734650613921, 6644.966775166094, 6651.0, 6661.633610151488, 4300.3549467580115, 4332.241857674957, 4349.260625693576, 4350.521442641244, 4354.0, 6332.715027823667, 6346.1432706585865, 6359.268684101387, 6363.96818015907, 6364.93635063662, 6116.0, 6174.9073763892675, 6201.255849298113, 6202.937970620236, 6207.286162091236, 6198.783042593487, 6201.410865967726, 6207.224096987877, 6207.565470417027, 6210.254769427697, 6097.085437184458, 6097.2988106366565, 6099.75600975956, 6100.420460056288, 6103.664298463449, 6153.13856060143, 6239.1577137087725, 6248.593841400295, 6254.343293954252, 6270.905936410866, 6055.0, 6091.0558863376245, 6093.055576385667, 6095.725692343766, 6120.663363515049], "yui.html": [769.6536558548654, 786.7167819584945, 795.1372760554798, 853.5007020892778, 869.0353707384802, 13679.589612311634, 13894.305284735774, 14045.227512486821, 14051.0, 14117.364718587662, 12925.806112908314, 13118.868811311884, 13205.801912971314, 13304.0, 13315.067945243813, 829.7427797382801, 844.252836239926, 846.6486408140614, 847.3390755210914, 847.3602430165216, 695.2074634916174, 705.4391758551964, 822.0751654388813, 828.4904783558129, 829.1501211258447, 885.5262434597491, 887.0331338840663, 894.472261365794, 894.5661354243186, 895.9776005599847, 885.1856292211116, 886.6276164011131, 886.6940905387631, 887.6671248281895, 887.9112088791134, 523.6910222968429, 530.5357811914574, 636.9777057802954, 651.3258777165659, 651.9771807986746, 12946.287954162517, 12995.285259310735, 13059.869401305961, 13090.280034598094, 13093.607191784262, 11945.402729863472, 12939.67650808728, 13023.739525209538, 13129.671758206026, 13198.878095361906, 10494.212934029978, 10629.255952083357, 10645.84031239532, 10686.625968091079, 10871.510782014828, 3599.190182209008, 3654.926901461956, 3681.7790932543867, 3720.5907350191455, 3768.1710023794994, 47289.527104728855, 47401.76299118482, 47490.525094748955, 47796.06956991251, 47829.0, 9344.953275233716, 9347.719568412958, 9754.365966212174, 9821.459819709842, 9846.261530385249, 19017.14422850975, 19246.326378576683, 19255.422337329903, 19258.22967081329, 19269.710954335696, 7676.19399963007, 7793.2596403341595, 7872.134065252818, 7942.245486678757, 8120.6345714443, 4284.404766649399, 4355.586219309161, 4386.934195987063, 4406.383106365111, 4491.393661855673, 3146.166265939528, 3162.367526494664, 3165.920851978719, 3166.699163579456, 3187.474066779002, 486.39443892354245, 490.443346801383, 499.86003918902765, 500.7746514068684, 507.82733870484213, 675.8884784010681, 706.8409607838298, 719.2771264878763, 727.436236916394, 730.2916171313817, 8732.170443807829, 9119.407238529475, 9263.0, 9363.344565880323, 9445.811083778286, 682.5733916302311, 684.1277371351566, 691.7544271783445, 692.8371832619331, 757.954522728638, 4031.5162180537936, 4193.287141186006, 4394.516603173648, 4423.20382331177, 4442.6890117691455, 55042.17436738452, 55320.0, 56773.43226567764, 56993.43006569964, 57179.0, 50197.49802502001, 50339.496605033484, 50822.49177508252, 51213.74393128085, 51245.743771280904, 44971.100577988254, 45498.31752523715, 45539.0, 45569.54430455653, 47556.0, 8413.87379189325, 8559.315254779478, 8718.433301835614, 8799.384043117176, 8848.336374772047, 33814.66185338115, 34261.82869085739, 34296.14259643529, 34796.304073917876, 34986.82506587451, 40121.39817902792, 40784.1843163141, 43194.784026079666, 45462.31806522971, 46187.0, 8093.635786389745, 8230.0, 8425.95787021061, 8516.276116530164, 8567.143285671384, 12478.5008599655, 12593.496260149492, 12595.181313214613, 12711.734099172365, 13084.934575327063, 11516.30902145874, 11594.71013224676, 11706.239094458833, 11732.413379330828, 11825.704357391134, 11761.893854136622, 11929.0, 11958.521659133537, 12016.699582510508, 12154.270743755404, 11713.88286117162, 11787.941060294643, 12031.45858436355, 12122.484689413823, 12357.814632780335, 10143.64497242593, 10216.846747298649, 10289.073983341535, 10294.897051029393, 10638.84041739359, 10208.54061567246, 10370.740731481774, 10387.480625968521, 10476.63331783384, 10519.579216831242]}, "summary": {"lowerIsBetter": false, "suite": 6692.869542171387, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6854.630942846786, "unit": "ms", "value": 6854.630942846786}, "dojo.html": {"lowerIsBetter": false, "filtered": 5318.315200319585, "unit": "ms", "value": 5318.315200319585}, "mootools.html": {"lowerIsBetter": false, "filtered": 4445.008301929901, "unit": "ms", "value": 4445.008301929901}, "ext.html": {"lowerIsBetter": false, "filtered": 18697.108655733395, "unit": "ms", "value": 18697.108655733395}, "prototype.html": {"lowerIsBetter": false, "filtered": 4650.253617011551, "unit": "ms", "value": 4650.253617011551}, "yui.html": {"lowerIsBetter": false, "filtered": 6379.024395697787, "unit": "ms", "value": 6379.024395697787}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447256467, "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": "20151111053051", "branch": "Fx-Team", "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 159.0, 161.0, 160.0, 160.0, 160.0, 160.0, 164.0, 161.0, 161.0], "ai-astar": [109.0, 112.0, 104.0, 110.0, 110.0, 110.0, 100.0, 110.0, 113.0, 109.0], "imaging-gaussian-blur": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "audio-beat-detection": [147.0, 126.0, 151.0, 164.0, 127.0, 153.0, 149.0, 125.0, 164.0, 125.0], "json-stringify-tinderbox": [67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [145.0, 149.0, 147.0, 150.0, 141.0, 142.0, 154.0, 154.0, 148.0, 142.0], "json-parse-financial": [59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 60.0, 72.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [68.0, 66.0, 67.0, 68.0, 67.0, 70.0, 67.0, 67.0, 67.0, 69.0], "audio-fft": [70.0, 71.0, 85.0, 95.0, 71.0, 71.0, 72.0, 120.0, 87.0, 72.0], "imaging-darkroom": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [122.0, 115.0, 115.0, 119.0, 123.0, 122.0, 131.0, 118.0, 121.0, 137.0], "audio-oscillator": [90.0, 90.0, 135.0, 89.0, 91.0, 91.0, 135.0, 90.0, 90.0, 137.0], "stanford-crypto-aes": [84.0, 84.0, 83.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 92.0], "imaging-desaturate": [96.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.8999999999999, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 81.4, "unit": "ms", "value": 81.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.2, "unit": "ms", "value": 147.2}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.1, "unit": "ms", "value": 143.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 122.3, "unit": "ms", "value": 122.3}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.2, "unit": "ms", "value": 59.2}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.8, "unit": "ms", "value": 103.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.7, "unit": "ms", "value": 108.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.6, "unit": "ms", "value": 160.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.6, "unit": "ms", "value": 67.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 67.6, "unit": "ms", "value": 67.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.9, "unit": "ms", "value": 84.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.4, "unit": "ms", "value": 95.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447256467, "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": "20151111053051", "branch": "Fx-Team", "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907"}}, {"talos_counters": {}, "results": {"DeltaBlue": [187.89928598271325], "Encrypt": [281.8489289740699], "NavierStokes": [4830.917874396136], "Decrypt": [5040.201005025126], "Splay": [638.1620931716656], "Richards": [163.31863465621427], "RegExp": [25717.94871794872], "Earley": [786.7820613690008], "Boyer": [11697.67441860465], "RayTrace": [1100.1100110011]}, "summary": {"lowerIsBetter": false, "suite": 21136.06409395671, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 351.879996, "unit": "score", "value": 351.879996}, "Encrypt": {"lowerIsBetter": false, "filtered": 944.410188, "unit": "score", "value": 944.410188}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 127.69639699999996, "unit": "score", "value": 127.69639699999996}, "RegExp": {"lowerIsBetter": false, "filtered": 35.42214855433696, "unit": "score", "value": 35.42214855433696}, "Richards": {"lowerIsBetter": false, "filtered": 216.15414600000005, "unit": "score", "value": 216.15414600000005}, "Earley": {"lowerIsBetter": false, "filtered": 847.0744729999998, "unit": "score", "value": 847.0744729999998}, "Boyer": {"lowerIsBetter": false, "filtered": 56.97397415506962, "unit": "score", "value": 56.97397415506962}, "RayTrace": {"lowerIsBetter": false, "filtered": 672.6500009999999, "unit": "score", "value": 672.6500009999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-016"}, "testrun": {"date": 1447256467, "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": "20151111053051", "branch": "Fx-Team", "revision": "2fc4d36aa30665f3d9bcb0fec4c48e045f2b4907"}}] 08:01:17 INFO - RETURN: dromaeo_css: 6692.87 08:01:17 INFO - RETURN: kraken: 1496.90 08:01:17 INFO - RETURN: v8_7: 21136.06 08:01:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "21136.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1496.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6692.87"}}} 08:01:17 INFO - Return code: 0 08:01:17 INFO - # TBPL SUCCESS # 08:01:17 INFO - Running post-action listener: _resource_record_post_action 08:01:17 INFO - Running post-run listener: _resource_record_post_run 08:01:18 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507940864; Read time: 16; Write time: 467588 08:01:18 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231907328; Read time: 0; Write time: 338336 08:01:18 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 275382272; Read time: 0; Write time: 129224 08:01:18 INFO - Running post-run listener: _upload_blobber_files 08:01:18 INFO - Blob upload gear active. 08:01:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:01:18 INFO - Copying logs to upload dir... 08:01:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.710185 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-11 08:01:18.232214) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 08:01:18.235391) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010070 build_url: 'https://queue.taskcluster.net/v1/task/jm2JNOPDRTq9nn1D7lie8A/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-11 08:01:18.286414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:01:18.286869) ========= 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=d6a7e047ef025f707024e163000001c3-1447256018.261488-496606295 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004773 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 08:01:18.337419) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 08:01:18.337736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 08:01:18.338038) ========= ========= Total master_lag: 0.30 =========