builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1450004613.51 results: success (0) buildid: 20151213004008 builduid: a9cc1a71c7204f8294c8ec1914f472cf revision: 0f9c2337da96fde3cc8f2c63200b56ee2578b6fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.508459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.508904) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.509243) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006475 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.566521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.566832) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.643758) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.644087) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.701232) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.701546) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.701929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.702251) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-13 03:03:34-- 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% 46.6M=0s 2015-12-13 03:03:34 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.910243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.910595) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017847 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.964039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:33.964450) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f9c2337da96fde3cc8f2c63200b56ee2578b6fd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f9c2337da96fde3cc8f2c63200b56ee2578b6fd --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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-13 03:03:35,101 truncating revision to first 12 chars 2015-12-13 03:03:35,101 Setting DEBUG logging. 2015-12-13 03:03:35,101 attempt 1/10 2015-12-13 03:03:35,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f9c2337da96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-13 03:03:35,429 unpacking tar archive at: mozilla-aurora-0f9c2337da96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635352 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:34.613514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:34.613895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:34.624411) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:34.624763) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-13 03:03:34.625286) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-13 03:03:34.625676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:03:35 INFO - MultiFileLogger online at 20151213 03:03:35 in /builds/slave/test-pgo 03:03:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:03:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:03:35 INFO - {'append_to_log': False, 03:03:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:03:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:03:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:03:35 INFO - 'branch': 'Mozilla-Aurora', 03:03:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:03:35 INFO - 'config_files': ('talos/linux_config.py',), 03:03:35 INFO - 'default_actions': ('clobber', 03:03:35 INFO - 'read-buildbot-config', 03:03:35 INFO - 'download-and-extract', 03:03:35 INFO - 'populate-webroot', 03:03:35 INFO - 'create-virtualenv', 03:03:35 INFO - 'install', 03:03:35 INFO - 'run-tests'), 03:03:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:03:35 INFO - 'download_minidump_stackwalk': True, 03:03:35 INFO - 'download_symbols': 'ondemand', 03:03:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:03:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:03:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:03:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:03:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:03:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:03:35 INFO - 'installer_path': 'installer.exe', 03:03:35 INFO - 'log_level': 'info', 03:03:35 INFO - 'log_name': 'talos', 03:03:35 INFO - 'log_to_console': True, 03:03:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:03:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:03:35 INFO - 'opt_config_files': (), 03:03:35 INFO - 'pip_index': False, 03:03:35 INFO - 'sps_profile': False, 03:03:35 INFO - 'sps_profile_interval': 0, 03:03:35 INFO - 'suite': 'dromaeojs-e10s', 03:03:35 INFO - 'system_bits': '64', 03:03:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:03:35 INFO - 'title': 'talos-linux64-ix-025', 03:03:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:03:35 INFO - 'use_talos_json': True, 03:03:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:03:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:03:35 INFO - 'work_dir': 'build'} 03:03:35 INFO - ##### 03:03:35 INFO - ##### Running clobber step. 03:03:35 INFO - ##### 03:03:35 INFO - Running pre-action listener: _resource_record_pre_action 03:03:35 INFO - Running main action method: clobber 03:03:35 INFO - rmtree: /builds/slave/test-pgo/build 03:03:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:03:36 INFO - Running post-action listener: _resource_record_post_action 03:03:36 INFO - ##### 03:03:36 INFO - ##### Running read-buildbot-config step. 03:03:36 INFO - ##### 03:03:36 INFO - Running pre-action listener: _resource_record_pre_action 03:03:36 INFO - Running main action method: read_buildbot_config 03:03:36 INFO - Using buildbot properties: 03:03:36 INFO - { 03:03:36 INFO - "properties": { 03:03:36 INFO - "buildnumber": 13, 03:03:36 INFO - "product": "firefox", 03:03:36 INFO - "script_repo_revision": "production", 03:03:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:03:36 INFO - "repository": "", 03:03:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:03:36 INFO - "buildid": "20151213004008", 03:03:36 INFO - "slavename": "talos-linux64-ix-025", 03:03:36 INFO - "stage_platform": "linux64-pgo", 03:03:36 INFO - "basedir": "/builds/slave/test-pgo", 03:03:36 INFO - "nightly_build": "True", 03:03:36 INFO - "project": "", 03:03:36 INFO - "platform": "ubuntu64_hw", 03:03:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:03:36 INFO - "slavebuilddir": "test", 03:03:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:03:36 INFO - "branch": "mozilla-aurora", 03:03:36 INFO - "repo_path": "releases/mozilla-aurora", 03:03:36 INFO - "pgo_build": "True", 03:03:36 INFO - "builduid": "a9cc1a71c7204f8294c8ec1914f472cf", 03:03:36 INFO - "revision": "0f9c2337da96fde3cc8f2c63200b56ee2578b6fd" 03:03:36 INFO - }, 03:03:36 INFO - "sourcestamp": { 03:03:36 INFO - "repository": "", 03:03:36 INFO - "hasPatch": false, 03:03:36 INFO - "project": "", 03:03:36 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:03:36 INFO - "changes": [ 03:03:36 INFO - { 03:03:36 INFO - "category": null, 03:03:36 INFO - "files": [ 03:03:36 INFO - { 03:03:36 INFO - "url": null, 03:03:36 INFO - "name": "https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2" 03:03:36 INFO - } 03:03:36 INFO - ], 03:03:36 INFO - "repository": "", 03:03:36 INFO - "rev": "0f9c2337da96fde3cc8f2c63200b56ee2578b6fd", 03:03:36 INFO - "who": "sendchange", 03:03:36 INFO - "when": 1450004611, 03:03:36 INFO - "number": 7355640, 03:03:36 INFO - "comments": "", 03:03:36 INFO - "project": "", 03:03:36 INFO - "at": "Sun 13 Dec 2015 03:03:31", 03:03:36 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:03:36 INFO - "revlink": "", 03:03:36 INFO - "properties": [ 03:03:36 INFO - [ 03:03:36 INFO - "buildid", 03:03:36 INFO - "20151213004008", 03:03:36 INFO - "Change" 03:03:36 INFO - ], 03:03:36 INFO - [ 03:03:36 INFO - "builduid", 03:03:36 INFO - "a9cc1a71c7204f8294c8ec1914f472cf", 03:03:36 INFO - "Change" 03:03:36 INFO - ], 03:03:36 INFO - [ 03:03:36 INFO - "nightly_build", 03:03:36 INFO - "True", 03:03:36 INFO - "Change" 03:03:36 INFO - ], 03:03:36 INFO - [ 03:03:36 INFO - "pgo_build", 03:03:36 INFO - "True", 03:03:36 INFO - "Change" 03:03:36 INFO - ] 03:03:36 INFO - ], 03:03:36 INFO - "revision": "0f9c2337da96fde3cc8f2c63200b56ee2578b6fd" 03:03:36 INFO - } 03:03:36 INFO - ], 03:03:36 INFO - "revision": "0f9c2337da96fde3cc8f2c63200b56ee2578b6fd" 03:03:36 INFO - } 03:03:36 INFO - } 03:03:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2. 03:03:36 INFO - Running post-action listener: _resource_record_post_action 03:03:36 INFO - ##### 03:03:36 INFO - ##### Running download-and-extract step. 03:03:36 INFO - ##### 03:03:36 INFO - Running pre-action listener: _resource_record_pre_action 03:03:36 INFO - Running main action method: download_and_extract 03:03:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:36 INFO - https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/test_packages.json 03:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/test_packages.json 03:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:03:38 INFO - Downloaded 1302 bytes. 03:03:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:03:38 INFO - Using the following test package requirements: 03:03:38 INFO - {u'common': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 03:03:38 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:03:38 INFO - u'jittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'jsshell-linux-x86_64.zip'], 03:03:38 INFO - u'mochitest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:03:38 INFO - u'mozbase': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 03:03:38 INFO - u'reftest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:03:38 INFO - u'talos': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:03:38 INFO - u'web-platform': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:03:38 INFO - u'webapprt': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 03:03:38 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 03:03:38 INFO - u'firefox-44.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:03:38 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:38 INFO - https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:03:39 INFO - Downloaded 22571948 bytes. 03:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:03:40 INFO - Return code: 0 03:03:40 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:40 INFO - https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:03:45 INFO - Downloaded 22571948 bytes. 03:03:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:03:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 03:03:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:03:46 INFO - Return code: 0 03:03:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:46 INFO - https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:03:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 03:03:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 03:03:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 03:03:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:03:48 INFO - Downloaded 11131970 bytes. 03:03:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:03:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 03:03:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:03:48 INFO - Return code: 0 03:03: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')]} 03:03:48 INFO - https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:03:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 03:03:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 03:03:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 03:03:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:03:49 INFO - Downloaded 56722009 bytes. 03:03:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 03:03:49 INFO - mkdir: /builds/slave/test-pgo/properties 03:03:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:03:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:03:49 INFO - Contents: 03:03:49 INFO - build_url:https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 03:03:49 INFO - Running post-action listener: _resource_record_post_action 03:03:49 INFO - Running post-action listener: set_extra_try_arguments 03:03:49 INFO - ##### 03:03:49 INFO - ##### Running populate-webroot step. 03:03:49 INFO - ##### 03:03:49 INFO - Running pre-action listener: _resource_record_pre_action 03:03:49 INFO - Running main action method: populate_webroot 03:03:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:03:49 INFO - '../fennec_ids.txt'], 03:03:49 INFO - 'tests': ['tcheck2']}, 03:03:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:49 INFO - '--tppagecycles', 03:03:49 INFO - '7'], 03:03:49 INFO - 'tests': ['tsvgm']}}, 03:03:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:03:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:03:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:03:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'tests': ['damp', 'tps']}, 03:03:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['damp', 'tps']}, 03:03:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:03:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:49 INFO - 'other': {'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'other_l64': {'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'other_nol64': {'tests': ['a11yr', 03:03:49 INFO - 'ts_paint', 03:03:49 INFO - 'tpaint', 03:03:49 INFO - 'sessionrestore', 03:03:49 INFO - 'sessionrestore_no_auto_restore']}, 03:03:49 INFO - 'svgr': {'tests': ['tsvgx', 03:03:49 INFO - 'tsvgr_opacity', 03:03:49 INFO - 'tart', 03:03:49 INFO - 'tscrollx', 03:03:49 INFO - 'cart']}, 03:03:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['tsvgx', 03:03:49 INFO - 'tsvgr_opacity', 03:03:49 INFO - 'tart', 03:03:49 INFO - 'tscrollx', 03:03:49 INFO - 'cart']}, 03:03:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'tests': ['tp5o']}, 03:03:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'talos_options': ['--e10s'], 03:03:49 INFO - 'tests': ['tp5o']}, 03:03:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'talos_options': ['--xperf_path', 03:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:49 INFO - 'tests': ['tp5n']}, 03:03:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:49 INFO - 'talos_options': ['--e10s', 03:03:49 INFO - '--xperf_path', 03:03:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:49 INFO - 'tests': ['tp5n']}}, 03:03:49 INFO - 'talos.zip': {'path': '', 03:03:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:49 INFO - Running post-action listener: _resource_record_post_action 03:03:49 INFO - ##### 03:03:49 INFO - ##### Running create-virtualenv step. 03:03:49 INFO - ##### 03:03:49 INFO - Running pre-action listener: _resource_record_pre_action 03:03:49 INFO - Running main action method: create_virtualenv 03:03:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:03:49 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 03:03:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:03:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:49 INFO - Using real prefix '/usr' 03:03:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:03:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:52 INFO - Installing pip.................done. 03:03:52 INFO - Return code: 0 03:03:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:03:52 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')]} 03:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 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')]} 03:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:03:52 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 03:03:52 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 03:03:52 INFO - Using env: {'DISPLAY': ':0', 03:03:52 INFO - 'HOME': '/home/cltbld', 03:03:52 INFO - 'LANG': 'en_US.UTF-8', 03:03:52 INFO - 'LANGUAGE': 'en_US:en', 03:03:52 INFO - 'LOGNAME': 'cltbld', 03:03:52 INFO - 'MAIL': '/var/mail/cltbld', 03:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:52 INFO - 'MOZ_NO_REMOTE': '1', 03:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:52 INFO - 'NO_EM_RESTART': '1', 03:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:03:52 INFO - 'SHELL': '/bin/bash', 03:03:52 INFO - 'SHLVL': '1', 03:03:52 INFO - 'TERM': 'linux', 03:03:52 INFO - 'TMOUT': '86400', 03:03:52 INFO - 'USER': 'cltbld', 03:03:52 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:52 INFO - '_': '/tools/buildbot/bin/python'} 03:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:52 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 03:03:52 INFO - Cleaning up... 03:03:52 INFO - Return code: 0 03:03:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:03:52 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')]} 03:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 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')]} 03:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:52 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:03:52 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 03:03:52 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 03:03:52 INFO - Using env: {'DISPLAY': ':0', 03:03:52 INFO - 'HOME': '/home/cltbld', 03:03:52 INFO - 'LANG': 'en_US.UTF-8', 03:03:52 INFO - 'LANGUAGE': 'en_US:en', 03:03:52 INFO - 'LOGNAME': 'cltbld', 03:03:52 INFO - 'MAIL': '/var/mail/cltbld', 03:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:52 INFO - 'MOZ_NO_REMOTE': '1', 03:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:52 INFO - 'NO_EM_RESTART': '1', 03:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:03:52 INFO - 'SHELL': '/bin/bash', 03:03:52 INFO - 'SHLVL': '1', 03:03:52 INFO - 'TERM': 'linux', 03:03:52 INFO - 'TMOUT': '86400', 03:03:52 INFO - 'USER': 'cltbld', 03:03:52 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:52 INFO - '_': '/tools/buildbot/bin/python'} 03:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:52 INFO - Downloading/unpacking psutil>=0.7.1 03:03:52 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 03:03:52 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 03:03:52 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 03:03:52 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 03:03:52 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 03:03:52 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 03:03:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:03:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:54 INFO - Installing collected packages: psutil 03:03:54 INFO - Running setup.py install for psutil 03:03:54 INFO - building 'psutil._psutil_linux' extension 03:03:54 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 03:03:54 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 03:03:54 INFO - building 'psutil._psutil_posix' extension 03:03:54 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 03:03:54 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 03:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:55 INFO - Successfully installed psutil 03:03:55 INFO - Cleaning up... 03:03:55 INFO - Return code: 0 03:03:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:03:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:03:55 INFO - Using env: {'DISPLAY': ':0', 03:03:55 INFO - 'HOME': '/home/cltbld', 03:03:55 INFO - 'LANG': 'en_US.UTF-8', 03:03:55 INFO - 'LANGUAGE': 'en_US:en', 03:03:55 INFO - 'LOGNAME': 'cltbld', 03:03:55 INFO - 'MAIL': '/var/mail/cltbld', 03:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:55 INFO - 'MOZ_NO_REMOTE': '1', 03:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:55 INFO - 'NO_EM_RESTART': '1', 03:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:03:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:03:55 INFO - 'SHELL': '/bin/bash', 03:03:55 INFO - 'SHLVL': '1', 03:03:55 INFO - 'TERM': 'linux', 03:03:55 INFO - 'TMOUT': '86400', 03:03:55 INFO - 'USER': 'cltbld', 03:03:55 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:55 INFO - '_': '/tools/buildbot/bin/python'} 03:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:03:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:03:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:03:56 INFO - Installing collected packages: mozsystemmonitor 03:03:56 INFO - Running setup.py install for mozsystemmonitor 03:03:57 INFO - Successfully installed mozsystemmonitor 03:03:57 INFO - Cleaning up... 03:03:57 INFO - Return code: 0 03:03:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:57 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:03:57 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 03:03:57 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 03:03:57 INFO - Using env: {'DISPLAY': ':0', 03:03:57 INFO - 'HOME': '/home/cltbld', 03:03:57 INFO - 'LANG': 'en_US.UTF-8', 03:03:57 INFO - 'LANGUAGE': 'en_US:en', 03:03:57 INFO - 'LOGNAME': 'cltbld', 03:03:57 INFO - 'MAIL': '/var/mail/cltbld', 03:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:57 INFO - 'MOZ_NO_REMOTE': '1', 03:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:57 INFO - 'NO_EM_RESTART': '1', 03:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:03:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:03:57 INFO - 'SHELL': '/bin/bash', 03:03:57 INFO - 'SHLVL': '1', 03:03:57 INFO - 'TERM': 'linux', 03:03:57 INFO - 'TMOUT': '86400', 03:03:57 INFO - 'USER': 'cltbld', 03:03:57 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:57 INFO - '_': '/tools/buildbot/bin/python'} 03:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 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 03:03:59 INFO - Downloading docopt-0.6.1.tar.gz 03:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:03:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:59 INFO - Running setup.py install for blobuploader 03:03:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:03:59 INFO - Running setup.py install for requests 03:04:00 INFO - Running setup.py install for docopt 03:04:00 INFO - Successfully installed blobuploader requests docopt 03:04:00 INFO - Cleaning up... 03:04:00 INFO - Return code: 0 03:04:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:00 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:04:00 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 03:04:00 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 03:04:00 INFO - Using env: {'DISPLAY': ':0', 03:04:00 INFO - 'HOME': '/home/cltbld', 03:04:00 INFO - 'LANG': 'en_US.UTF-8', 03:04:00 INFO - 'LANGUAGE': 'en_US:en', 03:04:00 INFO - 'LOGNAME': 'cltbld', 03:04:00 INFO - 'MAIL': '/var/mail/cltbld', 03:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:00 INFO - 'MOZ_NO_REMOTE': '1', 03:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:00 INFO - 'NO_EM_RESTART': '1', 03:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:00 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:00 INFO - 'SHELL': '/bin/bash', 03:04:00 INFO - 'SHLVL': '1', 03:04:00 INFO - 'TERM': 'linux', 03:04:00 INFO - 'TMOUT': '86400', 03:04:00 INFO - 'USER': 'cltbld', 03:04:00 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:00 INFO - '_': '/tools/buildbot/bin/python'} 03:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:04:00 INFO - Running setup.py (path:/tmp/pip-n7c2tU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:04:00 INFO - Running setup.py (path:/tmp/pip-bxTv32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:04:00 INFO - Running setup.py (path:/tmp/pip-zqgVa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:04:00 INFO - Running setup.py (path:/tmp/pip-w6_UPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:04:00 INFO - Running setup.py (path:/tmp/pip-PuKRAL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:04:00 INFO - Running setup.py (path:/tmp/pip-fXMvr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:04:00 INFO - Running setup.py (path:/tmp/pip-fjodww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:04:01 INFO - Running setup.py (path:/tmp/pip-ui7v2j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:04:01 INFO - Running setup.py (path:/tmp/pip-pyJE7R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:04:01 INFO - Running setup.py (path:/tmp/pip-TQ23g0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:04:01 INFO - Running setup.py (path:/tmp/pip-8ImP_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:04:01 INFO - Running setup.py (path:/tmp/pip-ZVGKEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:04:01 INFO - Running setup.py (path:/tmp/pip-L3kcEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:04:01 INFO - Running setup.py (path:/tmp/pip-RamTPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:04:01 INFO - Running setup.py (path:/tmp/pip-PSHmA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:04:01 INFO - Running setup.py (path:/tmp/pip-FmTa_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:04:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:04:01 INFO - Running setup.py (path:/tmp/pip-Rq0OUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:04:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:01 INFO - Running setup.py install for manifestparser 03:04:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:04:01 INFO - Running setup.py install for mozcrash 03:04:01 INFO - Running setup.py install for mozdebug 03:04:02 INFO - Running setup.py install for mozdevice 03:04:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for mozfile 03:04:02 INFO - Running setup.py install for mozhttpd 03:04:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for mozinfo 03:04:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for mozInstall 03:04:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for mozleak 03:04:02 INFO - Running setup.py install for mozlog 03:04:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for moznetwork 03:04:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:04:02 INFO - Running setup.py install for mozprocess 03:04:03 INFO - Running setup.py install for mozprofile 03:04:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:04:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:04:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:04:03 INFO - Running setup.py install for mozrunner 03:04:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:04:03 INFO - Running setup.py install for mozscreenshot 03:04:03 INFO - Running setup.py install for moztest 03:04:03 INFO - Running setup.py install for mozversion 03:04:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:04:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:03 INFO - Cleaning up... 03:04:03 INFO - Return code: 0 03:04:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:03 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:04:03 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 03:04:03 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 03:04:03 INFO - Using env: {'DISPLAY': ':0', 03:04:03 INFO - 'HOME': '/home/cltbld', 03:04:03 INFO - 'LANG': 'en_US.UTF-8', 03:04:03 INFO - 'LANGUAGE': 'en_US:en', 03:04:03 INFO - 'LOGNAME': 'cltbld', 03:04:03 INFO - 'MAIL': '/var/mail/cltbld', 03:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:03 INFO - 'MOZ_NO_REMOTE': '1', 03:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:03 INFO - 'NO_EM_RESTART': '1', 03:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:03 INFO - 'SHELL': '/bin/bash', 03:04:03 INFO - 'SHLVL': '1', 03:04:03 INFO - 'TERM': 'linux', 03:04:03 INFO - 'TMOUT': '86400', 03:04:03 INFO - 'USER': 'cltbld', 03:04:03 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:03 INFO - '_': '/tools/buildbot/bin/python'} 03:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:04:03 INFO - Running setup.py (path:/tmp/pip-F7Ia1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:04:03 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)) 03:04:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:04:03 INFO - Running setup.py (path:/tmp/pip-zh54CU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:04:03 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)) 03:04:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:04:03 INFO - Running setup.py (path:/tmp/pip-8SOjR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:04:03 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)) 03:04:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:04:04 INFO - Running setup.py (path:/tmp/pip-KOLpS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:04:04 INFO - Running setup.py (path:/tmp/pip-lORVrU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:04:04 INFO - Running setup.py (path:/tmp/pip-yl0Dcr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:04:04 INFO - Running setup.py (path:/tmp/pip-MPXT3c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:04:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:04:04 INFO - Running setup.py (path:/tmp/pip-g6PDGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:04:04 INFO - Running setup.py (path:/tmp/pip-GOLC9Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:04:04 INFO - Running setup.py (path:/tmp/pip-51OHRW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:04:04 INFO - Running setup.py (path:/tmp/pip-V7ZvMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:04:04 INFO - Running setup.py (path:/tmp/pip-8bzc9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:04:04 INFO - Running setup.py (path:/tmp/pip-eCOAco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:04:04 INFO - Running setup.py (path:/tmp/pip-Kbk5OX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:04:04 INFO - Running setup.py (path:/tmp/pip-ZayicZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:04:04 INFO - Running setup.py (path:/tmp/pip-Il06Hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:04:04 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)) 03:04:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:04:04 INFO - Running setup.py (path:/tmp/pip-bkkCIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:04:05 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)) 03:04:05 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)) 03:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:04:05 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)) 03:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:05 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:04:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:05 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 03:04:06 INFO - Downloading blessings-1.5.1.tar.gz 03:04:06 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 03:04:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:06 INFO - Installing collected packages: blessings 03:04:06 INFO - Running setup.py install for blessings 03:04:07 INFO - Successfully installed blessings 03:04:07 INFO - Cleaning up... 03:04:07 INFO - Return code: 0 03:04:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:04:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:04:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:04:07 INFO - Reading from file tmpfile_stdout 03:04:07 INFO - Current package versions: 03:04:07 INFO - argparse == 1.2.1 03:04:07 INFO - blessings == 1.5.1 03:04:07 INFO - blobuploader == 1.2.4 03:04:07 INFO - docopt == 0.6.1 03:04:07 INFO - manifestparser == 1.1 03:04:07 INFO - mozInstall == 1.12 03:04:07 INFO - mozcrash == 0.16 03:04:07 INFO - mozdebug == 0.1 03:04:07 INFO - mozdevice == 0.46 03:04:07 INFO - mozfile == 1.2 03:04:07 INFO - mozhttpd == 0.7 03:04:07 INFO - mozinfo == 0.8 03:04:07 INFO - mozleak == 0.1 03:04:07 INFO - mozlog == 3.0 03:04:07 INFO - moznetwork == 0.27 03:04:07 INFO - mozprocess == 0.22 03:04:07 INFO - mozprofile == 0.27 03:04:07 INFO - mozrunner == 6.11 03:04:07 INFO - mozscreenshot == 0.1 03:04:07 INFO - mozsystemmonitor == 0.0 03:04:07 INFO - moztest == 0.7 03:04:07 INFO - mozversion == 1.4 03:04:07 INFO - psutil == 3.1.1 03:04:07 INFO - requests == 1.2.3 03:04:07 INFO - wsgiref == 0.1.2 03:04:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 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 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:04:07 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 03:04:07 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 03:04:07 INFO - Using env: {'DISPLAY': ':0', 03:04:07 INFO - 'HOME': '/home/cltbld', 03:04:07 INFO - 'LANG': 'en_US.UTF-8', 03:04:07 INFO - 'LANGUAGE': 'en_US:en', 03:04:07 INFO - 'LOGNAME': 'cltbld', 03:04:07 INFO - 'MAIL': '/var/mail/cltbld', 03:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:07 INFO - 'MOZ_NO_REMOTE': '1', 03:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:07 INFO - 'NO_EM_RESTART': '1', 03:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:07 INFO - 'SHELL': '/bin/bash', 03:04:07 INFO - 'SHLVL': '1', 03:04:07 INFO - 'TERM': 'linux', 03:04:07 INFO - 'TMOUT': '86400', 03:04:07 INFO - 'USER': 'cltbld', 03:04:07 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:07 INFO - '_': '/tools/buildbot/bin/python'} 03:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 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)) 03:04:07 INFO - Cleaning up... 03:04:07 INFO - Return code: 0 03:04:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:07 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:04:07 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', 'jsonschema'] in /builds/slave/test-pgo/build 03:04:07 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 jsonschema 03:04:07 INFO - Using env: {'DISPLAY': ':0', 03:04:07 INFO - 'HOME': '/home/cltbld', 03:04:07 INFO - 'LANG': 'en_US.UTF-8', 03:04:07 INFO - 'LANGUAGE': 'en_US:en', 03:04:07 INFO - 'LOGNAME': 'cltbld', 03:04:07 INFO - 'MAIL': '/var/mail/cltbld', 03:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:07 INFO - 'MOZ_NO_REMOTE': '1', 03:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:07 INFO - 'NO_EM_RESTART': '1', 03:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:07 INFO - 'SHELL': '/bin/bash', 03:04:07 INFO - 'SHLVL': '1', 03:04:07 INFO - 'TERM': 'linux', 03:04:07 INFO - 'TMOUT': '86400', 03:04:07 INFO - 'USER': 'cltbld', 03:04:07 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:07 INFO - '_': '/tools/buildbot/bin/python'} 03:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:07 INFO - Downloading/unpacking jsonschema 03:04:07 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 03:04:07 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 03:04:07 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 03:04:07 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 03:04:07 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 03:04:07 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 03:04:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:04:09 INFO - Downloading/unpacking functools32 (from jsonschema) 03:04:09 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 03:04:09 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 03:04:09 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 03:04:09 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 03:04:09 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 03:04:09 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 03:04:09 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:04:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:09 INFO - warning: no files found matching '*.txt' 03:04:09 INFO - no previously-included directories found matching 'build' 03:04:09 INFO - no previously-included directories found matching 'dist' 03:04:09 INFO - no previously-included directories found matching '.git*' 03:04:09 INFO - Installing collected packages: jsonschema, functools32 03:04:09 INFO - Running setup.py install for functools32 03:04:10 INFO - warning: no files found matching '*.txt' 03:04:10 INFO - no previously-included directories found matching 'build' 03:04:10 INFO - no previously-included directories found matching 'dist' 03:04:10 INFO - no previously-included directories found matching '.git*' 03:04:10 INFO - Successfully installed jsonschema functools32 03:04:10 INFO - Cleaning up... 03:04:10 INFO - Return code: 0 03:04:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbf1b9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, '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': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', '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 03:04:10 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', 'flake8'] in /builds/slave/test-pgo/build 03:04:10 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 flake8 03:04:10 INFO - Using env: {'DISPLAY': ':0', 03:04:10 INFO - 'HOME': '/home/cltbld', 03:04:10 INFO - 'LANG': 'en_US.UTF-8', 03:04:10 INFO - 'LANGUAGE': 'en_US:en', 03:04:10 INFO - 'LOGNAME': 'cltbld', 03:04:10 INFO - 'MAIL': '/var/mail/cltbld', 03:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:10 INFO - 'MOZ_NO_REMOTE': '1', 03:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:10 INFO - 'NO_EM_RESTART': '1', 03:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:10 INFO - 'SHELL': '/bin/bash', 03:04:10 INFO - 'SHLVL': '1', 03:04:10 INFO - 'TERM': 'linux', 03:04:10 INFO - 'TMOUT': '86400', 03:04:10 INFO - 'USER': 'cltbld', 03:04:10 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:10 INFO - '_': '/tools/buildbot/bin/python'} 03:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:10 INFO - Downloading/unpacking flake8 03:04:10 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 03:04:10 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 03:04:10 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 03:04:10 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 03:04:10 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 03:04:10 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 03:04:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:04:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:04:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:04:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:04:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:04:12 INFO - no previously-included directories found matching 'docs/_build' 03:04:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:04:12 INFO - Running setup.py install for pep8 03:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:04:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:04:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:04:12 INFO - no previously-included directories found matching 'docs/_build' 03:04:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:04:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:04:12 INFO - Cleaning up... 03:04:12 INFO - Return code: 0 03:04:12 INFO - Running post-action listener: _resource_record_post_action 03:04:12 INFO - Running post-action listener: _start_resource_monitoring 03:04:12 INFO - Starting resource monitoring. 03:04:12 INFO - ##### 03:04:12 INFO - ##### Running install step. 03:04:12 INFO - ##### 03:04:12 INFO - Running pre-action listener: _resource_record_pre_action 03:04:12 INFO - Running main action method: install 03:04:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:04:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:04:13 INFO - Reading from file tmpfile_stdout 03:04:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:04:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:04:13 INFO - Reading from file tmpfile_stdout 03:04:13 INFO - Output received: 03:04:13 INFO - Usage: mozinstall [options] installer 03:04:13 INFO - Options: 03:04:13 INFO - -h, --help show this help message and exit 03:04:13 INFO - -d DEST, --destination=DEST 03:04:13 INFO - Directory to install application into. [default: 03:04:13 INFO - "/builds/slave/test-pgo"] 03:04:13 INFO - --app=APP Application being installed. [default: firefox] 03:04:13 INFO - mkdir: /builds/slave/test-pgo/build/application 03:04:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:04:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:04:27 INFO - Reading from file tmpfile_stdout 03:04:27 INFO - Output received: 03:04:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:04:27 INFO - Running post-action listener: _resource_record_post_action 03:04:27 INFO - ##### 03:04:27 INFO - ##### Running run-tests step. 03:04:27 INFO - ##### 03:04:27 INFO - Running pre-action listener: _resource_record_pre_action 03:04:27 INFO - Running main action method: run_tests 03:04:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:04:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:04:27 INFO - Python 2.7.3 03:04:27 INFO - Return code: 0 03:04:27 INFO - grabbing minidump binary from tooltool 03:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:27 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 0x1131a50>, '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 0x109d550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:04:27 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 03:04:27 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 03:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:04:27 INFO - Return code: 0 03:04:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:04:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:04:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:04:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:04:28 INFO - Return code: 0 03:04:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:04:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 03:04:28 INFO - Using env: {'DISPLAY': ':0', 03:04:28 INFO - 'HOME': '/home/cltbld', 03:04:28 INFO - 'LANG': 'en_US.UTF-8', 03:04:28 INFO - 'LANGUAGE': 'en_US:en', 03:04:28 INFO - 'LOGNAME': 'cltbld', 03:04:28 INFO - 'MAIL': '/var/mail/cltbld', 03:04:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:04:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:28 INFO - 'MOZ_NO_REMOTE': '1', 03:04:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:28 INFO - 'NO_EM_RESTART': '1', 03:04:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:04:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:04:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:04:28 INFO - 'SHELL': '/bin/bash', 03:04:28 INFO - 'SHLVL': '1', 03:04:28 INFO - 'TERM': 'linux', 03:04:28 INFO - 'TMOUT': '86400', 03:04:28 INFO - 'USER': 'cltbld', 03:04:28 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449987567.131810-1440514756', 03:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:28 INFO - '_': '/tools/buildbot/bin/python'} 03:04:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 03:04:28 INFO - mozversion INFO | application_buildid: 20151213004008 03:04:28 INFO - mozversion INFO | application_changeset: 0f9c2337da96fde3cc8f2c63200b56ee2578b6fd 03:04:28 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:04:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:04:28 INFO - mozversion INFO | application_name: Firefox 03:04:28 INFO - mozversion INFO | application_remotingname: firefox-dev 03:04:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:28 INFO - mozversion INFO | application_vendor: Mozilla 03:04:28 INFO - mozversion INFO | application_version: 44.0a2 03:04:28 INFO - mozversion INFO | platform_buildid: 20151213004008 03:04:28 INFO - mozversion INFO | platform_changeset: 0f9c2337da96fde3cc8f2c63200b56ee2578b6fd 03:04:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:04:28 INFO - mozversion INFO | platform_version: 44.0a2 03:04:28 INFO - 2015-12-13 03:04:28,698 DEBUG : using testdate: 1450004668 03:04:28 INFO - 2015-12-13 03:04:28,698 DEBUG : actual date: 1450004668 03:04:28 INFO - 2015-12-13 03:04:28,706 INFO : starting webserver on 'localhost:32785' 03:04:28 INFO - 2015-12-13 03:04:28,707 INFO : Starting test suite talos-linux64-ix-025.e 03:04:28 INFO - 2015-12-13 03:04:28,707 INFO : Starting test dromaeo_css 03:04:28 INFO - 2015-12-13 03:04:28,707 DEBUG : operating with platform_type : linux_ 03:04:28 INFO - 2015-12-13 03:04:28,707 INFO : Initialising browser for dromaeo_css test... 03:04:28 INFO - 2015-12-13 03:04:28,724 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3iVXKa/profile http://localhost:32785/getInfo.html 03:04:33 INFO - 2015-12-13 03:04:33,580 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:04:33 INFO - 2015-12-13 03:04:33,581 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:04:33 INFO - 2015-12-13 03:04:33,581 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 03:04:33 INFO - 2015-12-13 03:04:33,581 DEBUG : BROWSER_OUTPUT: __metrics 03:04:34 INFO - 2015-12-13 03:04:34,521 INFO : Browser initialized. 03:04:34 INFO - 2015-12-13 03:04:34,521 INFO : Running cycle 1/1 for dromaeo_css test... 03:04:34 INFO - 2015-12-13 03:04:34,521 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3iVXKa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:04:46 INFO - 2015-12-13 03:04:46,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 133005312 03:04:46 INFO - 2015-12-13 03:04:46,154 DEBUG : BROWSER_OUTPUT: 03:05:35 INFO - 2015-12-13 03:05:35,801 DEBUG : BROWSER_OUTPUT: 1450004735795 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] 03:07:43 INFO - 2015-12-13 03:07:43,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32785/tests/dromaeo/cssquery-ext.html) 03:07:44 INFO - 2015-12-13 03:07:44,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 137605120 03:07:44 INFO - 2015-12-13 03:07:44,557 DEBUG : BROWSER_OUTPUT: 03:10:46 INFO - 2015-12-13 03:10:46,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-ext.html (next: http://localhost:32785/tests/dromaeo/cssquery-jquery.html) 03:10:46 INFO - 2015-12-13 03:10:46,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 137134080 03:10:46 INFO - 2015-12-13 03:10:46,868 DEBUG : BROWSER_OUTPUT: 03:13:48 INFO - 2015-12-13 03:13:48,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32785/tests/dromaeo/cssquery-mootools.html) 03:13:48 INFO - 2015-12-13 03:13:48,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 135610368 03:13:48 INFO - 2015-12-13 03:13:48,970 DEBUG : BROWSER_OUTPUT: 03:16:50 INFO - 2015-12-13 03:16:50,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32785/tests/dromaeo/cssquery-prototype.html) 03:16:51 INFO - 2015-12-13 03:16:51,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 136151040 03:16:51 INFO - 2015-12-13 03:16:51,139 DEBUG : BROWSER_OUTPUT: 03:19:53 INFO - 2015-12-13 03:19:53,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32785/tests/dromaeo/cssquery-yui.html) 03:19:54 INFO - 2015-12-13 03:19:54,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 137129984 03:19:54 INFO - 2015-12-13 03:19:54,000 DEBUG : BROWSER_OUTPUT: 03:22:55 INFO - 2015-12-13 03:22:55,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/dromaeo/cssquery-yui.html (next: http://localhost:32785/tests/dromaeo/cssquery-dojo.html) 03:22:56 INFO - 2015-12-13 03:22:56,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 138199040 03:22:56 INFO - 2015-12-13 03:22:56,234 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,235 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:22:56 INFO - 2015-12-13 03:22:56,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:22:56 INFO - 2015-12-13 03:22:56,236 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:22:56 INFO - 2015-12-13 03:22:56,236 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:22:56 INFO - 2015-12-13 03:22:56,237 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3304.6199687035987;3310.6358300586944;3329.317489914568;3338.449155889278;3347.899563013109;5631.887362252753;5658.009848276556;5703.144528320749;5724.713764311783;5727.513161381283;5701.942980570193;5723.54211663067;5737.426257374261;5744.885102297952;5748.885022299552;5152.072626927152;5222;5276.234945932837;5278.947210527884;5286.7885284588765;5008.949910500903;5126.769295381698;5135.4094279158;5139.640225184238;5253.86865328366;5295.920561191585;5316.6544174628525;5358.2498450217;5369.838904832861;5392.137258038714;5221.086309895772;5223.555997740196;5226;5242;5249.343832020997;4963.751812409401;5002.374703162105;5046.823361182341;5067.619928505377;5106.4638212987475;5413.945860541384;5459.044667183227;5509.090999984997;5524.033294173544;5547.057000309957;6136.325004249529;6168.568200225986;6173.32093469718;6175.228096487939;6182.5363097767395;5886.499647529922;5980.581359304851;6050.334463209044;6063.454289114001;6189.845253868644;5690.715464226813;5723.885522289531;5755.22304488897;5769.653820770725;5777.711114444303;6148.938510614926;6191.25704915413;6200.410960958701;6216.409441103088;6233.719482623293;5900.704964751745;5979.581429299994;6010.158577799111;6038.486728628116;6105.633661980207;6101.020999420504;6179.84550386244;6187.783427580013;6190.7523699052435;6210.4410603045035;5950.732217050243;6132.01899668756;6145.907811382833;6176.135341052256;6200.224971878515;5906.409359064145;5950.464458198696;5999.640021598718;6007.068904319837;6052.243469566304;4659.254519276899;4660.277656963176;4661.580457758818;4662.883427914329;4671.929921051187;4083.4895638045246;4154.667626589866;4156.9792151039655;4178.979105104516;4210.221109094766;5740.311162660508;5744.454276843693;5780.248567686258;5786.566007549366;5843.328017277982;6114.877702446015;6185.072239164161;6189.566730328924;6199.3490683478485;6235.781747638811;5628.183913332626;5733.31200255972;5832.270966129234;5911.261092363455;5949.077892926603;5376.274202982548;5379.327584051994;5384.6769193848495;5386.192071189274;5398.055340315429;6329.905051424233;6366.713497892606;6372.203474565679;6374.808755737336;6409.327020662763;5975.9103613446705;6015.39846015395;6122.479589234965;6142.846428839315;6196.287426945869;6276.9372306276355;6387.904181437375;6396.776112836028;6407.038944158227;6409.487241020801;6113.266408031065;6128.9693551531955;6131.049687298476;6137.754489820357;6141.969290153521;6016.308124565731;6033;6118.162361256354;6128.319797384666;6143.877122457615;6079.787207447718;6088.665123418077;6102.786402475892;6114.205153330038;6118.20463339763;5849.502792262535;6031.306399763907;6061.909071364022;6073.301570319293;6074.301455332693;5807;5850.356460789395;5881.794137205177;5942.702864856654;5991.850203744942;6034.577579569388;6084.60450070744;6085;6086.969565152146;6095.725692343944;5649.067903795828;5767.106098554731;5960.642361458326;5966.134910437875;5973.193618861398 03:22:56 INFO - 2015-12-13 03:22:56,238 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.7053702611666;610.8656095658955;618.7648693496469;640.1901594482977;642.9260635026973;34783.82608086959;42651;42754.144917101716;43113.35329970053;43284.783576082074;47949.52050479494;48368.75815620926;48542.05831766734;48550.514494855044;48574;9191.724248272563;9336.486493242868;9374.437533747998;9389.953050234773;9442.10300021497;9209.539523023856;9282.767930801716;9331.206847417978;9339.112784285517;9340.252779777635;9256.074392560724;9332.906670933271;9337.206337461324;9353.924298705633;9363.297752668543;9309;9370.67202647911;9371.531423428802;9380.296477764161;9383.202427793645;9156.313276504223;9269.907300926972;9275.860862087007;9286.303527235485;9290.860637090449;44185.558144418465;44358.33462498065;44441.55558444439;44828.3275750864;44921.775391122836;3719.386301260316;3739.4016957286703;3818.2554401891643;3833.5974722654278;4218.936715949263;32706.67293327084;32740.508892366634;33135;33165;34100.97697069092;4012.7191096623246;4052.5136983561865;4055.452513910643;4084.9183016339507;4100.753954762694;339306;341703;341809;343049;343238;46704;47407.525924741;47474;47540.762296188295;69711.65144174246;45878.770606147424;45976.77011614921;46041.76979115083;46100.7694961523;46120.077598447846;17258.13709314529;17328.393506227472;17424.12879356027;17436.389726359517;17436.825631743774;14208.147511149364;14219.431222751182;14293.070950388399;14305.427782888568;14392.712145757236;16012.359505619877;16020;16036.198190090448;16068.75896861548;16082.839171608368;6238.844028899314;6382.63842378323;6384.744610215539;6522.34776522344;6546.345365463416;1002.734275417015;1074.8871368506195;1094.141099237095;1157.479134389528;1242.7514497100617;30319;30852.228694282374;31070;31621.525677114863;31724.206894827814;1126.099120703434;1144.0904480937675;1151.0216316131389;1151.5393842462913;1250.0749445410513;15463.149526776135;15668.68662626764;15701;15733.606659833596;16122.274497647633;443319;523626;536732;539580;542317;67259.66370168216;68440;68488;68522;68601;1526.3894442222977;1542.537238828347;1543.1589783568206;1545.0575149159004;1551.612096975756;33189.668103318654;33248.833755832035;33573;33678.32643347168;34223.97328080161;52417;52788.736056319474;52897.206541901134;53069.20396193983;53162.4683753173;327530;331245;332783;333127;334292;36457.63542364542;37308.440373394966;37406.438903417016;37674.62325376711;37710.81144594259;48678.51321486881;49673.50326496689;49854;50256.24615630695;50417;41418.1716365665;41717;41753;42029.36955945724;42753.86230688515;41781.79109104435;41807.581924181584;42274;42661.78669106634;42833.357499636906;42108.789456052524;42943.141137176455;43006;43486.782566086964;43522.69431917048;35556.466652999705;35709.46435803413;36183;36543.45184822283;37431.43852842155;28606.42787144204;28872.711272887;29096.7090329094;29103.41793164167;29158.854205728836 03:22:56 INFO - 2015-12-13 03:22:56,239 DEBUG : BROWSER_OUTPUT: |2;jquery.html;391.0302449924188;391.33277761416787;394.0739262732579;397.035204453179;397.05698964958225;12474.688132796684;13104.213747175176;18307.267709291627;20076.89961550192;20124.09441575129;13680.24758638277;14121.78817317741;14213.71572568548;14294.356753946071;14420;5005.1491246488185;5147.794088236466;5149.613778966574;5158.458361872005;5244.921326180111;5212.192110222903;5272.551833094191;5330.600204984622;5334.03987282289;5340.492653197959;5296.602754793386;5312.60155488338;5321.308229930104;5323.653962492425;5543.251661025771;5502.5597952163735;5511.22842802008;5517.862053448655;5519.448055194489;5522.447755224485;4692.085043416535;4745.525447455227;4753.33453316536;4780.1873681474235;4816.51834816519;15397;15468;15617.219139043002;15749.527514174479;15775.053496790115;2055.1779288284656;2155.7305336832897;2173.815225705817;2229.710137682107;2281.5436912617542;11186.832197517044;11393.316401015965;11494.712632184179;11571.074314054855;11655.76688466226;1739.4086010756403;1778.9110544472724;1820.2173065581794;1838.7241913712917;1857.860660450458;63553.68223158901;64209;71310.64344678295;72338.63830680866;72829;7861.4103942204565;7923.12845586985;8080.757577272691;8121.26908578219;8126.146754590801;9549.045095490395;9566.56950437232;9683.41899486033;9693.369930954465;9705.466199358962;6624.238212605515;6723.5293529452465;6741.966290168616;6745.156855393076;6792.796216113525;7117.217106118323;7117.75087871922;7176.627832748181;7183;7188.964055179691;3656.1590834108306;3732.664060234592;3753.9436908446396;3755.4930084438797;3783.697304215656;1288.6520639427301;1304.7194853106437;1310.8361454818148;1318.4989703912452;1360.3878254785386;470.962323014158;478.83480199331177;480.9302651115569;491.2582001178247;495.32140966875613;13376.933115334361;13732.45070197181;13740.381682824296;13845.653858653413;13992.020558560804;512.4593553800776;518.8547206782032;527.5463101732507;535.4591862219187;542.4331573505617;7430.182679905206;7435.107787065586;7562.773116806505;7701.152873184057;7785.182555831556;559600;561213;562483;565886;572010;82585;85518;85924;86087.13912860917;86364.13635863562;574.3509833887764;578.5024878604397;579.0908274009848;579.965202087876;581.0615855393594;12114.394280285775;12675.556355527513;12686.746265074831;12805.487780488676;12859.614211573667;36712;36780;37029.25941481209;37829.24341513099;38076.42885356777;46094;47378;48286.792830179525;51046.744766277414;53189.7340513295;7581;7720.266574675396;7730.381569474541;7767.572783496962;7768.339691126317;11614.303141811519;13610.93194534021;14053.22707251111;14419.495317663832;14431.134131952116;12124.393780310773;12148.696282593006;12256.203346782431;12435.689107772378;12444.751104978031;11795.587154449553;12164.574239901915;12215.206011609573;12456;12545.87454125447;11867.821982670439;12228.32744199042;12277.69305767363;12354.196977196454;12929.935350323565;7740.496867703807;7795.454318197899;7854.60726963661;7867.252611001945;7878.369730421437;12471.438785254504;12511.56209532662;12578.685532861751;12610.87389126097;12930.547430839875 03:22:56 INFO - 2015-12-13 03:22:56,239 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1525.4432132271718;1585.4371698047194;1633.338497908346;1761.9207135678894;1859.330640969251;7785.571793551359;8055.476394034384;8083.353331733462;8124;8333.958330208356;8336.541490218036;8360.581970901461;8391.496510209376;8435.70475033374;8510.659573617064;2463.1502131764555;2500.8999640014376;2510.0210917742097;2512.6859142607173;2521.2940376694555;2464.544059349017;2472.0235506974736;2487.514934587756;2489.65144879717;2491.476789874129;2400.3519049856527;2437.6709144265565;2444.4133407982044;2446.412860913386;2463.9137630182945;2366.95266094678;2415.734269230392;2427.5023620157826;2448.681671382718;2468.1978357033854;2481.5161043596504;2504.0734928076545;2525.065725681491;2525.3181640957023;2538;8228.547429891354;8290.626921788535;8313;8321.292690121347;8336.583170841433;5118.436971933084;5191.662541934762;5218.191180367049;5231.973840130775;5232.293640358541;3338.6494418085995;3368.0906155338166;3378.510116033186;3395.8623861006345;3408.1309266137223;1195.3007490618;1200.7118291610038;1210.5097435538532;1229.2685851918095;1229.7356068445326;11217.15871309655;11258.831117533244;11280.548778048867;11284.605038823684;11294.717632059183;4535.682502224812;4571.634269258451;4572.428446444194;4578.725276483422;4660.487346391894;9277.536123193813;9291.163795258459;9291.814163716688;9296.488693121808;9309.441433513875;5124.897502050013;5141.151709967889;5141.640085194001;5147.871303217375;5158.097332966716;4728.243481043017;4730.976345118322;4736.029114031615;4744.810207591658;4748.833790817304;3753.9061523462133;3842.0971071798103;3865.43951127085;3867.4778904847485;3870.729048966545;1076.39721755817;1134.4271143072694;1151.476078384333;1160.3038177093676;1174.9530018799153;1004.7538353103537;1111.8721347045032;1185.7806305833276;1374.113696665645;1450.9492167774076;7510.887336689954;7568.508046976929;7592.126905405838;7595.012648355789;7605.6957721691615;764.1829063826113;789.7828097273295;795.7572940253278;796.69725504308;895.4582477601087;6221;6292.653904035322;6294.622322660563;6308.968455157695;6323;9621.470819105016;10095.899041009643;10103.949480252699;10127.139193168663;10147.391156530632;9784.510774461249;9787.265955053257;9820.852687209697;9839.3112482127;9941.45322007282;7109.537880037781;7151.928480715231;7158.3557479828105;7200.243974382719;7280.563166210044;7812.570308632852;7845.960770196112;7860.0567931848545;7884.960575197088;7907.683692652229;8806.823863522566;8932.508712020901;8989.685361012333;9006.189442950166;9037.457752534869;9135.588898499716;9194.770130746785;9215.907840921773;9242.584083716383;9350.53247337644;7335.303146201102;7409.184989651242;7417.147028091623;7437.367823735043;7443.665035073543;8149.674013039412;8162.5510596915365;8256.587170641324;8259.83480330402;8274.875876861972;6574.112494813139;7490.737824176128;7621.809454763676;7676.961615191888;7804.8829267559895;7019.333163349474;7227.891581626385;7282.708691652275;7442;7589.203133670885;7558.811029724301;7573.507721998052;7584.658690358837;7626.54240745557;7626.771196864103;6799.694013769294;6799.762008329685;6810.148731408574;6864.313568643295;6895.103636527219;7178.712851485882;7195.38839198653;7211.71153153868;7229.49393542468;7258.3104605062435 03:22:56 INFO - 2015-12-13 03:22:56,241 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.80637665225737;370.058201876225;372.0345702900972;374.7994822769817;383.36170276489645;6098.908516372258;6176.9691151544175;6213.130161777355;6252.937470625298;6263.279722831876;6033.974224381855;6079.604825686327;6109.663968481732;6132.693365331738;6133.233345831771;4687.789049492772;4694.788734506938;4713.505081966396;4716.268978308368;4730.290456431529;4732.266498692708;4739.786709598059;4749.026449577846;4762.404699412574;4765.213739732957;4678.111158879802;4696;4740.85777426676;4750.738709370983;4759.881002974936;4684.976575117136;4716.457607375144;4730.385049943519;4735.124002059612;4755.334253204554;4176.415301857743;4181.728187667792;4181.958180418187;4188.539260681323;4189.539150693421;5789.2763404574425;5828.271466066742;5845.795397161079;5861.9706901465215;5869.559783016248;5446.291982042309;5514.420985796514;5517.862053448696;5518.255035570187;5519.31008623922;6471.61170329777;6476.93523064768;6480.254770701383;6487.091807147003;6489.545731798776;4633.814647414099;4634.096351211515;4639.744814035227;4641.3270075839155;4643.558861908147;6629.138212032453;6630.038644396584;6663.167104111986;6688.197416310074;6736.360045795642;4696.201645720167;4712.670113092119;4723.645726570521;4735.147673418749;4735.8342458014495;4717.599004084691;4771.6898401603785;4776.832810851603;4786.970801277742;4798.688085274446;5461.644993075437;5472.26124473199;5482.0406428875585;5493.2034854945805;5499.862503437366;6393.328700486475;6511.186101737283;6580.506462015368;6605.966970165118;6612.140421745238;1714.4942242038628;1742.1811748478194;1742.817004214539;1759.727242277449;1765.4615342320715;1177.2347973816916;1178.7288923547633;1180.114913814639;1181.2144923625692;1191.2018947305326;6256.6871656417;6264.59280146789;6267.874642507216;6269.65516896566;6270.028145637433;6591.209054913345;6637.966810165918;6639.402453779183;6650.501212409089;6651.467882569383;6222.12890195373;6279.843003924939;6288.496920246369;6301.747930082837;6332.271788744261;3664.4320130379833;3681.9815900920858;3707.5921648618632;3710.109573702292;3711.2391959648207;6840.3501667341525;6844.726210951606;6874.209465911485;6884.65576721162;6941.375276225164;6782.2200446948245;6867.416269617039;6915.51591388608;6927.653617319113;6930.480213983971;6881.208661003949;6882.8623427532175;6907;6917.89623155653;6923.4807389446;6646.401823835878;6671.833204169935;6714.83212919681;6728.428083612947;6732.764353247613;6618.404343609098;6663.033860090163;6668.733250669919;6674.332566743481;6708.865822683617;7061.82345441368;7070.787876363717;7077.079979602619;7081.725289447949;7086.114235720535;4768.737719425465;4815.7351345676325;4819.156647586588;4819.855404337875;4824.589909857701;6630.972199309115;6752.08846805675;6842.144731908512;6857.862842743018;6860.176778786577;6572.7042283098335;6601.801945941629;6628.602283862983;6631.535792494479;6637.601743895381;6575.4410875076155;6585.242697089704;6594.406503414716;6598.868022639424;6599.109120268702;6414.871702566016;6442.387973142544;6472.320406357453;6474.902876456763;6490.48076153916;6647.734090636321;6698;6704.396604305636;6713.362230588086;6724.495662825406;6508.869822603616;6509.641969691713;6514.3811337922825;6523.706433210612;6564.113844630913 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: |5;yui.html;835.9832803343937;849.172057244187;948.3314263444272;949.672363034753;963.7927845513213;11610.941945290273;11720;11744.647660570176;11749.471273792678;11798.174127811057;14114.57656270311;14231;14236.28818559073;14247;14274.072185307949;776.2664282253273;777.7588947426316;904.2856143646511;932.4172392254841;936.9109934556241;880.5729221327683;922.1608336413865;923.6767131503954;924.4869097650801;927.323054170456;910.0535443139128;959.366817900186;961.1974001708581;964.6527250189926;966.3718582921123;909.5997760985146;937.4515908193681;941.6610020392619;942.9905700942971;945.4138434170858;695.6417445015821;700.9614471204081;703.022798310349;703.2299631903059;706.4630880530782;14879.553613391507;15011.774823377658;15016.549503514912;15040.398384064625;15049.473268435662;13636.659083522893;14091.577252682437;14494.782578261334;14717.116972981656;14749.11505309674;11353.432328383631;11561.132915031407;11709.414529273503;11716.53133874644;11778.411079445994;3982.4026396040827;3983.6813054955533;3999.200159968018;4043.575424580406;4110.630043296118;49064.50935490671;49100.263496047584;49148.75425622849;49278.26082608764;55527.16709249365;8375.396900092554;8531.06158322584;8617.827643447095;8757.16806903356;8810.118988101138;13773.793393099111;13795.172289662652;13801.861981380258;13803.930980345034;13811.51659691906;7306.342429181399;7333.816654583678;7385.187629360766;7908.130105688369;7960.601969901481;4866.683665561798;4913.361263035782;4922.680025798311;4942.9011419771405;5015.27278544609;2883.3656595548946;2886.4371447567523;2914.2714321419644;2915.19832046189;2916.198045537494;472.5581581221569;475.57198521331077;481.38863643172976;481.7831975610989;482.4837423956333;621.7761605821901;672.4922683374022;731.2323649803253;741.7552207771422;753.7474945893077;9082.318826087938;9334;9456.57445414958;9478.857817132748;9497.715068547956;693.9410150137194;774.601080443572;794.1899262751961;796.494226166377;807.7495976247382;4293.935590966138;4499.122671079173;4538.341940418687;4646.651501137429;4670.486246512881;64900.35099649037;65632.67183664051;65738;69181.3081869175;69786.65106674434;60429.39570604326;60442.39557604455;60784;61151;61239;55210.447895521334;55532.16701749477;55621.16568251399;55676.72161639166;56063.71968140133;9495.097965693249;9512.571934262836;9540.141387275178;9674.322797404115;9749.951250243703;40541.39187912125;42208.15583688371;42226.09982550854;42299.57700423079;43539.56460435482;53837.46162538324;54303;55052;55382.72308638592;55509.167362488784;8413.915860841558;9048.954755226181;9094.681686141217;9149.77125571866;9303.813923721624;12357.32034738062;12686.555970541356;12713.42789574453;12894.548690795777;13255.734885302047;12059.095567832272;12111.394430278628;12191.085668574715;12380.62858114258;12412.503499859904;11790.351530665552;11972.281663100242;12064.396780161132;12248.75502489963;12305;12025.699357516132;12199.878001219875;12386.442610082388;12985.675358116123;13216.273104979318;10255.07704306616;10402.427866467417;10436.321639093434;10508.054275115277;10598.576056957943;9967.950160249153;10431.68704938853;10602.151827853908;10609.310394824312;10610.363378197333 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,270 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: __startTimestamp1450005776234__endTimestamp 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:22:56 INFO - 2015-12-13 03:22:56,242 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:22:56 INFO - 2015-12-13 03:22:56,243 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,243 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5686.27 Median:5911.26 stddev:651.49 (11.0%) stddev-sans-first:626.13 03:22:56 INFO - 2015-12-13 03:22:56,243 DEBUG : BROWSER_OUTPUT: Values: 3304.6 3310.6 3329.3 3338.4 3347.9 5631.9 5658.0 5703.1 5724.7 5727.5 5701.9 5723.5 5737.4 5744.9 5748.9 5152.1 5222.0 5276.2 5278.9 5286.8 5008.9 5126.8 5135.4 5139.6 5253.9 5295.9 5316.7 5358.2 5369.8 5392.1 5221.1 5223.6 5226.0 5242.0 5249.3 4963.8 5002.4 5046.8 5067.6 5106.5 5413.9 5459.0 5509.1 5524.0 5547.1 6136.3 6168.6 6173.3 6175.2 6182.5 5886.5 5980.6 6050.3 6063.5 6189.8 5690.7 5723.9 5755.2 5769.7 5777.7 6148.9 6191.3 6200.4 6216.4 6233.7 5900.7 5979.6 6010.2 6038.5 6105.6 6101.0 6179.8 6187.8 6190.8 6210.4 5950.7 6132.0 6145.9 6176.1 6200.2 5906.4 5950.5 5999.6 6007.1 6052.2 4659.3 4660.3 4661.6 4662.9 4671.9 4083.5 4154.7 4157.0 4179.0 4210.2 5740.3 5744.5 5780.2 5786.6 5843.3 6114.9 6185.1 6189.6 6199.3 6235.8 5628.2 5733.3 5832.3 5911.3 5949.1 5376.3 5379.3 5384.7 5386.2 5398.1 6329.9 6366.7 6372.2 6374.8 6409.3 5975.9 6015.4 6122.5 6142.8 6196.3 6276.9 6387.9 6396.8 6407.0 6409.5 6113.3 6129.0 6131.0 6137.8 6142.0 6016.3 6033.0 6118.2 6128.3 6143.9 6079.8 6088.7 6102.8 6114.2 6118.2 5849.5 6031.3 6061.9 6073.3 6074.3 5807.0 5850.4 5881.8 5942.7 5991.9 6034.6 6084.6 6085.0 6087.0 6095.7 5649.1 5767.1 5960.6 5966.1 5973.2 03:22:56 INFO - 2015-12-13 03:22:56,243 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,243 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56948.90 Median:42069.08 stddev:107474.12 (255.5%) stddev-sans-first:107692.27 03:22:56 INFO - 2015-12-13 03:22:56,245 DEBUG : BROWSER_OUTPUT: Values: 577.7 610.9 618.8 640.2 642.9 34783.8 42651.0 42754.1 43113.4 43284.8 47949.5 48368.8 48542.1 48550.5 48574.0 9191.7 9336.5 9374.4 9390.0 9442.1 9209.5 9282.8 9331.2 9339.1 9340.3 9256.1 9332.9 9337.2 9353.9 9363.3 9309.0 9370.7 9371.5 9380.3 9383.2 9156.3 9269.9 9275.9 9286.3 9290.9 44185.6 44358.3 44441.6 44828.3 44921.8 3719.4 3739.4 3818.3 3833.6 4218.9 32706.7 32740.5 33135.0 33165.0 34101.0 4012.7 4052.5 4055.5 4084.9 4100.8 339306.0 341703.0 341809.0 343049.0 343238.0 46704.0 47407.5 47474.0 47540.8 69711.7 45878.8 45976.8 46041.8 46100.8 46120.1 17258.1 17328.4 17424.1 17436.4 17436.8 14208.1 14219.4 14293.1 14305.4 14392.7 16012.4 16020.0 16036.2 16068.8 16082.8 6238.8 6382.6 6384.7 6522.3 6546.3 1002.7 1074.9 1094.1 1157.5 1242.8 30319.0 30852.2 31070.0 31621.5 31724.2 1126.1 1144.1 1151.0 1151.5 1250.1 15463.1 15668.7 15701.0 15733.6 16122.3 443319.0 523626.0 536732.0 539580.0 542317.0 67259.7 68440.0 68488.0 68522.0 68601.0 1526.4 1542.5 1543.2 1545.1 1551.6 33189.7 33248.8 33573.0 33678.3 34224.0 52417.0 52788.7 52897.2 53069.2 53162.5 327530.0 331245.0 332783.0 333127.0 334292.0 36457.6 37308.4 37406.4 37674.6 37710.8 48678.5 49673.5 49854.0 50256.2 50417.0 41418.2 41717.0 41753.0 42029.4 42753.9 41781.8 41807.6 42274.0 42661.8 42833.4 42108.8 42943.1 43006.0 43486.8 43522.7 35556.5 35709.5 36183.0 36543.5 37431.4 28606.4 28872.7 29096.7 29103.4 29158.9 03:22:56 INFO - 2015-12-13 03:22:56,245 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,245 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29003.19 Median:2616.08 stddev:92537.59 (3537.3%) stddev-sans-first:92772.24 03:22:56 INFO - 2015-12-13 03:22:56,246 DEBUG : BROWSER_OUTPUT: Values: 391.0 391.3 394.1 397.0 397.1 12474.7 13104.2 18307.3 20076.9 20124.1 13680.2 14121.8 14213.7 14294.4 14420.0 5005.1 5147.8 5149.6 5158.5 5244.9 5212.2 5272.6 5330.6 5334.0 5340.5 5296.6 5312.6 5321.3 5323.7 5543.3 5502.6 5511.2 5517.9 5519.4 5522.4 4692.1 4745.5 4753.3 4780.2 4816.5 15397.0 15468.0 15617.2 15749.5 15775.1 2055.2 2155.7 2173.8 2229.7 2281.5 11186.8 11393.3 11494.7 11571.1 11655.8 1739.4 1778.9 1820.2 1838.7 1857.9 63553.7 64209.0 71310.6 72338.6 72829.0 7861.4 7923.1 8080.8 8121.3 8126.1 9549.0 9566.6 9683.4 9693.4 9705.5 6624.2 6723.5 6742.0 6745.2 6792.8 7117.2 7117.8 7176.6 7183.0 7189.0 3656.2 3732.7 3753.9 3755.5 3783.7 1288.7 1304.7 1310.8 1318.5 1360.4 471.0 478.8 480.9 491.3 495.3 13376.9 13732.5 13740.4 13845.7 13992.0 512.5 518.9 527.5 535.5 542.4 7430.2 7435.1 7562.8 7701.2 7785.2 559600.0 561213.0 562483.0 565886.0 572010.0 82585.0 85518.0 85924.0 86087.1 86364.1 574.4 578.5 579.1 580.0 581.1 12114.4 12675.6 12686.7 12805.5 12859.6 36712.0 36780.0 37029.3 37829.2 38076.4 46094.0 47378.0 48286.8 51046.7 53189.7 7581.0 7720.3 7730.4 7767.6 7768.3 11614.3 13610.9 14053.2 14419.5 14431.1 12124.4 12148.7 12256.2 12435.7 12444.8 11795.6 12164.6 12215.2 12456.0 12545.9 11867.8 12228.3 12277.7 12354.2 12929.9 7740.5 7795.5 7854.6 7867.3 7878.4 12471.4 12511.6 12578.7 12610.9 12930.5 03:22:56 INFO - 2015-12-13 03:22:56,246 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,247 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5822.29 Median:6799.73 stddev:2988.91 (44.0%) stddev-sans-first:2979.84 03:22:56 INFO - 2015-12-13 03:22:56,248 DEBUG : BROWSER_OUTPUT: Values: 1525.4 1585.4 1633.3 1761.9 1859.3 7785.6 8055.5 8083.4 8124.0 8334.0 8336.5 8360.6 8391.5 8435.7 8510.7 2463.2 2500.9 2510.0 2512.7 2521.3 2464.5 2472.0 2487.5 2489.7 2491.5 2400.4 2437.7 2444.4 2446.4 2463.9 2367.0 2415.7 2427.5 2448.7 2468.2 2481.5 2504.1 2525.1 2525.3 2538.0 8228.5 8290.6 8313.0 8321.3 8336.6 5118.4 5191.7 5218.2 5232.0 5232.3 3338.6 3368.1 3378.5 3395.9 3408.1 1195.3 1200.7 1210.5 1229.3 1229.7 11217.2 11258.8 11280.5 11284.6 11294.7 4535.7 4571.6 4572.4 4578.7 4660.5 9277.5 9291.2 9291.8 9296.5 9309.4 5124.9 5141.2 5141.6 5147.9 5158.1 4728.2 4731.0 4736.0 4744.8 4748.8 3753.9 3842.1 3865.4 3867.5 3870.7 1076.4 1134.4 1151.5 1160.3 1175.0 1004.8 1111.9 1185.8 1374.1 1450.9 7510.9 7568.5 7592.1 7595.0 7605.7 764.2 789.8 795.8 796.7 895.5 6221.0 6292.7 6294.6 6309.0 6323.0 9621.5 10095.9 10103.9 10127.1 10147.4 9784.5 9787.3 9820.9 9839.3 9941.5 7109.5 7151.9 7158.4 7200.2 7280.6 7812.6 7846.0 7860.1 7885.0 7907.7 8806.8 8932.5 8989.7 9006.2 9037.5 9135.6 9194.8 9215.9 9242.6 9350.5 7335.3 7409.2 7417.1 7437.4 7443.7 8149.7 8162.6 8256.6 8259.8 8274.9 6574.1 7490.7 7621.8 7677.0 7804.9 7019.3 7227.9 7282.7 7442.0 7589.2 7558.8 7573.5 7584.7 7626.5 7626.8 6799.7 6799.8 6810.1 6864.3 6895.1 7178.7 7195.4 7211.7 7229.5 7258.3 03:22:56 INFO - 2015-12-13 03:22:56,248 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,248 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5494.57 Median:6259.98 stddev:1622.34 (25.9%) stddev-sans-first:1580.62 03:22:56 INFO - 2015-12-13 03:22:56,249 DEBUG : BROWSER_OUTPUT: Values: 368.8 370.1 372.0 374.8 383.4 6098.9 6177.0 6213.1 6252.9 6263.3 6034.0 6079.6 6109.7 6132.7 6133.2 4687.8 4694.8 4713.5 4716.3 4730.3 4732.3 4739.8 4749.0 4762.4 4765.2 4678.1 4696.0 4740.9 4750.7 4759.9 4685.0 4716.5 4730.4 4735.1 4755.3 4176.4 4181.7 4182.0 4188.5 4189.5 5789.3 5828.3 5845.8 5862.0 5869.6 5446.3 5514.4 5517.9 5518.3 5519.3 6471.6 6476.9 6480.3 6487.1 6489.5 4633.8 4634.1 4639.7 4641.3 4643.6 6629.1 6630.0 6663.2 6688.2 6736.4 4696.2 4712.7 4723.6 4735.1 4735.8 4717.6 4771.7 4776.8 4787.0 4798.7 5461.6 5472.3 5482.0 5493.2 5499.9 6393.3 6511.2 6580.5 6606.0 6612.1 1714.5 1742.2 1742.8 1759.7 1765.5 1177.2 1178.7 1180.1 1181.2 1191.2 6256.7 6264.6 6267.9 6269.7 6270.0 6591.2 6638.0 6639.4 6650.5 6651.5 6222.1 6279.8 6288.5 6301.7 6332.3 3664.4 3682.0 3707.6 3710.1 3711.2 6840.4 6844.7 6874.2 6884.7 6941.4 6782.2 6867.4 6915.5 6927.7 6930.5 6881.2 6882.9 6907.0 6917.9 6923.5 6646.4 6671.8 6714.8 6728.4 6732.8 6618.4 6663.0 6668.7 6674.3 6708.9 7061.8 7070.8 7077.1 7081.7 7086.1 4768.7 4815.7 4819.2 4819.9 4824.6 6631.0 6752.1 6842.1 6857.9 6860.2 6572.7 6601.8 6628.6 6631.5 6637.6 6575.4 6585.2 6594.4 6598.9 6599.1 6414.9 6442.4 6472.3 6474.9 6490.5 6647.7 6698.0 6704.4 6713.4 6724.5 6508.9 6509.6 6514.4 6523.7 6564.1 03:22:56 INFO - 2015-12-13 03:22:56,249 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,250 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15275.28 Median:27110.58 stddev:18777.96 (69.3%) stddev-sans-first:18799.33 03:22:56 INFO - 2015-12-13 03:22:56,250 DEBUG : BROWSER_OUTPUT: Values: 836.0 849.2 948.3 949.7 963.8 11610.9 11720.0 11744.6 11749.5 11798.2 14114.6 14231.0 14236.3 14247.0 14274.1 776.3 777.8 904.3 932.4 936.9 880.6 922.2 923.7 924.5 927.3 910.1 959.4 961.2 964.7 966.4 909.6 937.5 941.7 943.0 945.4 695.6 701.0 703.0 703.2 706.5 14879.6 15011.8 15016.5 15040.4 15049.5 13636.7 14091.6 14494.8 14717.1 14749.1 11353.4 11561.1 11709.4 11716.5 11778.4 3982.4 3983.7 3999.2 4043.6 4110.6 49064.5 49100.3 49148.8 49278.3 55527.2 8375.4 8531.1 8617.8 8757.2 8810.1 13773.8 13795.2 13801.9 13803.9 13811.5 7306.3 7333.8 7385.2 7908.1 7960.6 4866.7 4913.4 4922.7 4942.9 5015.3 2883.4 2886.4 2914.3 2915.2 2916.2 472.6 475.6 481.4 481.8 482.5 621.8 672.5 731.2 741.8 753.7 9082.3 9334.0 9456.6 9478.9 9497.7 693.9 774.6 794.2 796.5 807.7 4293.9 4499.1 4538.3 4646.7 4670.5 64900.4 65632.7 65738.0 69181.3 69786.7 60429.4 60442.4 60784.0 61151.0 61239.0 55210.4 55532.2 55621.2 55676.7 56063.7 9495.1 9512.6 9540.1 9674.3 9750.0 40541.4 42208.2 42226.1 42299.6 43539.6 53837.5 54303.0 55052.0 55382.7 55509.2 8413.9 9049.0 9094.7 9149.8 9303.8 12357.3 12686.6 12713.4 12894.5 13255.7 12059.1 12111.4 12191.1 12380.6 12412.5 11790.4 11972.3 12064.4 12248.8 12305.0 12025.7 12199.9 12386.4 12985.7 13216.3 10255.1 10402.4 10436.3 10508.1 10598.6 9968.0 10431.7 10602.2 10609.3 10610.4 03:22:56 INFO - 2015-12-13 03:22:56,250 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:22:56 INFO - 2015-12-13 03:22:56,250 DEBUG : BROWSER_OUTPUT: 03:22:56 INFO - 2015-12-13 03:22:56,885 INFO : Browser exited with error code: 0 03:22:56 INFO - 2015-12-13 03:22:56,903 INFO : Completed test dromaeo_css (00:18:28) 03:22:56 INFO - 2015-12-13 03:22:56,903 INFO : Starting test kraken 03:22:56 INFO - 2015-12-13 03:22:56,903 DEBUG : operating with platform_type : linux_ 03:22:56 INFO - 2015-12-13 03:22:56,903 INFO : Initialising browser for kraken test... 03:22:56 INFO - 2015-12-13 03:22:56,909 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOuQtls/profile http://localhost:32785/getInfo.html 03:23:01 INFO - 2015-12-13 03:23:01,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:23:01 INFO - 2015-12-13 03:23:01,381 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:23:01 INFO - 2015-12-13 03:23:01,381 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 03:23:01 INFO - 2015-12-13 03:23:01,381 DEBUG : BROWSER_OUTPUT: __metrics 03:23:02 INFO - 2015-12-13 03:23:02,345 INFO : Browser initialized. 03:23:02 INFO - 2015-12-13 03:23:02,345 INFO : Running cycle 1/1 for kraken test... 03:23:02 INFO - 2015-12-13 03:23:02,345 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOuQtls/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:23:13 INFO - 2015-12-13 03:23:13,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 133472256 03:23:13 INFO - 2015-12-13 03:23:13,962 DEBUG : BROWSER_OUTPUT: 03:23:16 INFO - 2015-12-13 03:23:16,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32785/tests/kraken/driver.html?testName=audio-beat-detection) 03:23:16 INFO - 2015-12-13 03:23:16,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 134377472 03:23:16 INFO - 2015-12-13 03:23:16,983 DEBUG : BROWSER_OUTPUT: 03:23:19 INFO - 2015-12-13 03:23:19,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32785/tests/kraken/driver.html?testName=audio-dft) 03:23:20 INFO - 2015-12-13 03:23:20,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 134799360 03:23:20 INFO - 2015-12-13 03:23:20,167 DEBUG : BROWSER_OUTPUT: 03:23:22 INFO - 2015-12-13 03:23:22,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32785/tests/kraken/driver.html?testName=audio-fft) 03:23:23 INFO - 2015-12-13 03:23:23,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 135688192 03:23:23 INFO - 2015-12-13 03:23:23,559 DEBUG : BROWSER_OUTPUT: 03:23:25 INFO - 2015-12-13 03:23:25,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32785/tests/kraken/driver.html?testName=audio-oscillator) 03:23:26 INFO - 2015-12-13 03:23:26,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 135737344 03:23:26 INFO - 2015-12-13 03:23:26,119 DEBUG : BROWSER_OUTPUT: 03:23:28 INFO - 2015-12-13 03:23:28,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32785/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:23:28 INFO - 2015-12-13 03:23:28,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 135487488 03:23:28 INFO - 2015-12-13 03:23:28,863 DEBUG : BROWSER_OUTPUT: 03:23:31 INFO - 2015-12-13 03:23:31,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32785/tests/kraken/driver.html?testName=imaging-darkroom) 03:23:32 INFO - 2015-12-13 03:23:32,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 135352320 03:23:32 INFO - 2015-12-13 03:23:32,429 DEBUG : BROWSER_OUTPUT: 03:23:35 INFO - 2015-12-13 03:23:35,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32785/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:36 INFO - 2015-12-13 03:23:36,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 135847936 03:23:36 INFO - 2015-12-13 03:23:36,356 DEBUG : BROWSER_OUTPUT: 03:23:39 INFO - 2015-12-13 03:23:39,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32785/tests/kraken/driver.html?testName=json-parse-financial) 03:23:39 INFO - 2015-12-13 03:23:39,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 135766016 03:23:39 INFO - 2015-12-13 03:23:39,774 DEBUG : BROWSER_OUTPUT: 03:23:41 INFO - 2015-12-13 03:23:41,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32785/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:41 INFO - 2015-12-13 03:23:41,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 135700480 03:23:41 INFO - 2015-12-13 03:23:41,894 DEBUG : BROWSER_OUTPUT: 03:23:43 INFO - 2015-12-13 03:23:43,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:44 INFO - 2015-12-13 03:23:44,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 135794688 03:23:44 INFO - 2015-12-13 03:23:44,279 DEBUG : BROWSER_OUTPUT: 03:23:46 INFO - 2015-12-13 03:23:46,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:46 INFO - 2015-12-13 03:23:46,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 136335360 03:23:46 INFO - 2015-12-13 03:23:46,873 DEBUG : BROWSER_OUTPUT: 03:23:49 INFO - 2015-12-13 03:23:49,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:49 INFO - 2015-12-13 03:23:49,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 136126464 03:23:49 INFO - 2015-12-13 03:23:49,871 DEBUG : BROWSER_OUTPUT: 03:23:52 INFO - 2015-12-13 03:23:52,366 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:52 INFO - 2015-12-13 03:23:52,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 135573504 03:23:52 INFO - 2015-12-13 03:23:52,948 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32785/tests/kraken/driver.html?testName=ai-astar) 03:23:54 INFO - 2015-12-13 03:23:54,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 135827456 03:23:54 INFO - 2015-12-13 03:23:54,822 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,824 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:23:54 INFO - 2015-12-13 03:23:54,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:23:54 INFO - 2015-12-13 03:23:54,824 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:23:54 INFO - 2015-12-13 03:23:54,824 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:23:54 INFO - 2015-12-13 03:23:54,825 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;104;109;110;110;119;109;110;109;110 03:23:54 INFO - 2015-12-13 03:23:54,825 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;122;147;165;126;148;144;123;162;123 03:23:54 INFO - 2015-12-13 03:23:54,825 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;164;161;162;160;161;161;163;162 03:23:54 INFO - 2015-12-13 03:23:54,826 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;148;71;71;71;72;153;70 03:23:54 INFO - 2015-12-13 03:23:54,826 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;129;88;93;89;135;89;89;141 03:23:54 INFO - 2015-12-13 03:23:54,826 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;109;109;110;110;110 03:23:54 INFO - 2015-12-13 03:23:54,826 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;147;146;146;147;147;148;147 03:23:54 INFO - 2015-12-13 03:23:54,826 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;95;95;96;97;97;95 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;66;59;59;60;59;72;58;59 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;62;62;64;63;63;63;62;63;62;64 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;80;83;82;83;81;81;82;82;82 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;116;118;113;120;121;119;120;113;117 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;140;143;139;141;147;150;155;141;141 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;64;65;65;67;68;64;63;63;62 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,706 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: __startTimestamp1450005834823__endTimestamp 03:23:54 INFO - 2015-12-13 03:23:54,827 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:3.67 (3.3%) stddev-sans-first:3.87 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: Values: 109.0 104.0 109.0 110.0 110.0 119.0 109.0 110.0 109.0 110.0 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.50 stddev:16.48 (11.2%) stddev-sans-first:17.09 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: Values: 151.0 122.0 147.0 165.0 126.0 148.0 144.0 123.0 162.0 123.0 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,829 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:23:54 INFO - 2015-12-13 03:23:54,830 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 164.0 161.0 162.0 160.0 161.0 161.0 163.0 162.0 03:23:54 INFO - 2015-12-13 03:23:54,830 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:71.00 stddev:33.49 (47.2%) stddev-sans-first:35.02 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 148.0 71.0 71.0 71.0 72.0 153.0 70.0 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:89.00 stddev:22.17 (24.9%) stddev-sans-first:22.99 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 129.0 88.0 93.0 89.0 135.0 89.0 89.0 141.0 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,831 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 148.0 147.0 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 97.0 97.0 95.0 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.50 stddev:4.50 (7.6%) stddev-sans-first:4.76 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 66.0 59.0 59.0 60.0 59.0 72.0 58.0 59.0 03:23:54 INFO - 2015-12-13 03:23:54,832 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: Values: 62.0 62.0 64.0 63.0 63.0 63.0 62.0 63.0 62.0 64.0 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.07 (1.3%) stddev-sans-first:0.97 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 83.0 82.0 83.0 81.0 81.0 82.0 82.0 82.0 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:118.50 stddev:2.90 (2.4%) stddev-sans-first:2.96 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: Values: 115.0 116.0 118.0 113.0 120.0 121.0 119.0 120.0 113.0 117.0 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:143.00 stddev:5.12 (3.6%) stddev-sans-first:5.42 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: Values: 143.0 140.0 143.0 139.0 141.0 147.0 150.0 155.0 141.0 141.0 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.00 (3.1%) stddev-sans-first:1.94 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: Values: 62.0 64.0 65.0 65.0 67.0 68.0 64.0 63.0 63.0 62.0 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:23:54 INFO - 2015-12-13 03:23:54,833 DEBUG : BROWSER_OUTPUT: 03:23:55 INFO - 2015-12-13 03:23:55,573 INFO : Browser exited with error code: 0 03:23:55 INFO - 2015-12-13 03:23:55,626 INFO : Completed test kraken (00:00:58) 03:23:55 INFO - 2015-12-13 03:23:55,626 INFO : Starting test v8_7 03:23:55 INFO - 2015-12-13 03:23:55,626 DEBUG : operating with platform_type : linux_ 03:23:55 INFO - 2015-12-13 03:23:55,626 INFO : Initialising browser for v8_7 test... 03:23:55 INFO - 2015-12-13 03:23:55,632 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kVceF/profile http://localhost:32785/getInfo.html 03:24:00 INFO - 2015-12-13 03:24:00,227 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:24:00 INFO - 2015-12-13 03:24:00,227 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:24:00 INFO - 2015-12-13 03:24:00,227 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 03:24:00 INFO - 2015-12-13 03:24:00,227 DEBUG : BROWSER_OUTPUT: __metrics 03:24:01 INFO - 2015-12-13 03:24:01,244 INFO : Browser initialized. 03:24:01 INFO - 2015-12-13 03:24:01,245 INFO : Running cycle 1/1 for v8_7 test... 03:24:01 INFO - 2015-12-13 03:24:01,245 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kVceF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:24:12 INFO - 2015-12-13 03:24:12,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 133980160 03:24:12 INFO - 2015-12-13 03:24:12,947 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32785/tests/v8_7/run.html (next: http://localhost:32785/tests/v8_7/run.html) 03:24:34 INFO - 2015-12-13 03:24:34,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 133443584 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: |0;Richards;163.07893020221786 03:24:34 INFO - 2015-12-13 03:24:34,586 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.91095539224065 03:24:34 INFO - 2015-12-13 03:24:34,587 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 03:24:34 INFO - 2015-12-13 03:24:34,587 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 03:24:34 INFO - 2015-12-13 03:24:34,587 DEBUG : BROWSER_OUTPUT: |4;RayTrace;910.7468123861566 03:24:34 INFO - 2015-12-13 03:24:34,587 DEBUG : BROWSER_OUTPUT: |5;Earley;544.3658138268917 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: |6;Boyer;10458.333333333334 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: |7;RegExp;23395.3488372093 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: |8;Splay;518.4033177812338 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: __startTimestamp1450005874584__endTimestamp 03:24:34 INFO - 2015-12-13 03:24:34,588 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.08 Median:163.08 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: Values: 163.1 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.91 Median:170.91 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: Values: 170.9 03:24:34 INFO - 2015-12-13 03:24:34,589 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,590 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,590 DEBUG : BROWSER_OUTPUT: Values: 278.9 03:24:34 INFO - 2015-12-13 03:24:34,590 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,590 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: Values: 5040.2 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:910.75 Median:910.75 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: Values: 910.7 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,591 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.37 Median:544.37 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,592 DEBUG : BROWSER_OUTPUT: Values: 544.4 03:24:34 INFO - 2015-12-13 03:24:34,592 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,592 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10458.33 Median:10458.33 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,593 DEBUG : BROWSER_OUTPUT: Values: 10458.3 03:24:34 INFO - 2015-12-13 03:24:34,593 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,593 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23395.35 Median:23395.35 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,593 DEBUG : BROWSER_OUTPUT: Values: 23395.3 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: Values: 518.4 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: Values: 4854.4 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:24:34 INFO - 2015-12-13 03:24:34,594 DEBUG : BROWSER_OUTPUT: 03:24:35 INFO - 2015-12-13 03:24:35,353 INFO : Browser exited with error code: 0 03:24:35 INFO - 2015-12-13 03:24:35,369 INFO : Completed test v8_7 (00:00:39) 03:24:35 INFO - 2015-12-13 03:24:35,620 INFO : Completed test suite (00:20:06) 03:24:35 INFO - 2015-12-13 03:24:35,620 DEBUG : Working with test: dromaeo_css 03:24:35 INFO - 2015-12-13 03:24:35,620 DEBUG : Generating results file: dromaeo_css 03:24:35 INFO - 2015-12-13 03:24:35,621 DEBUG : Working with test: kraken 03:24:35 INFO - 2015-12-13 03:24:35,621 DEBUG : Generating results file: kraken 03:24:35 INFO - 2015-12-13 03:24:35,622 INFO : javascript benchmark 03:24:35 INFO - 2015-12-13 03:24:35,622 DEBUG : Working with test: v8_7 03:24:35 INFO - 2015-12-13 03:24:35,622 DEBUG : Generating results file: v8_7 03:24:35 INFO - 2015-12-13 03:24:35,622 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:24:35 INFO - 2015-12-13 03:24:35,777 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:24:35 INFO - 2015-12-13 03:24:35,778 DEBUG : process_Request line: dromaeo_css 7224.65 graph.html#tests=[[72,52,43]] 03:24:35 INFO - 2015-12-13 03:24:35,778 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:24:35 INFO - 2015-12-13 03:24:35,944 DEBUG : process_Request line: kraken 1486.30 graph.html#tests=[[232,52,43]] 03:24:35 INFO - 2015-12-13 03:24:35,944 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:24:36 INFO - 2015-12-13 03:24:36,086 DEBUG : process_Request line: v8_7 23527.51 graph.html#tests=[[230,52,43]] 03:24:36 INFO - 2015-12-13 03:24:36,088 INFO : javascript benchmark 03:24:36 INFO - 2015-12-13 03:24:36,091 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3304.6199687035987, 3310.6358300586944, 3329.317489914568, 3338.449155889278, 3347.899563013109, 5631.887362252753, 5658.009848276556, 5703.144528320749, 5724.713764311783, 5727.513161381283, 5701.942980570193, 5723.54211663067, 5737.426257374261, 5744.885102297952, 5748.885022299552, 5152.072626927152, 5222.0, 5276.234945932837, 5278.947210527884, 5286.7885284588765, 5008.949910500903, 5126.769295381698, 5135.4094279158, 5139.640225184238, 5253.86865328366, 5295.920561191585, 5316.6544174628525, 5358.2498450217, 5369.838904832861, 5392.137258038714, 5221.086309895772, 5223.555997740196, 5226.0, 5242.0, 5249.343832020997, 4963.751812409401, 5002.374703162105, 5046.823361182341, 5067.619928505377, 5106.4638212987475, 5413.945860541384, 5459.044667183227, 5509.090999984997, 5524.033294173544, 5547.057000309957, 6136.325004249529, 6168.568200225986, 6173.32093469718, 6175.228096487939, 6182.5363097767395, 5886.499647529922, 5980.581359304851, 6050.334463209044, 6063.454289114001, 6189.845253868644, 5690.715464226813, 5723.885522289531, 5755.22304488897, 5769.653820770725, 5777.711114444303, 6148.938510614926, 6191.25704915413, 6200.410960958701, 6216.409441103088, 6233.719482623293, 5900.704964751745, 5979.581429299994, 6010.158577799111, 6038.486728628116, 6105.633661980207, 6101.020999420504, 6179.84550386244, 6187.783427580013, 6190.7523699052435, 6210.4410603045035, 5950.732217050243, 6132.01899668756, 6145.907811382833, 6176.135341052256, 6200.224971878515, 5906.409359064145, 5950.464458198696, 5999.640021598718, 6007.068904319837, 6052.243469566304, 4659.254519276899, 4660.277656963176, 4661.580457758818, 4662.883427914329, 4671.929921051187, 4083.4895638045246, 4154.667626589866, 4156.9792151039655, 4178.979105104516, 4210.221109094766, 5740.311162660508, 5744.454276843693, 5780.248567686258, 5786.566007549366, 5843.328017277982, 6114.877702446015, 6185.072239164161, 6189.566730328924, 6199.3490683478485, 6235.781747638811, 5628.183913332626, 5733.31200255972, 5832.270966129234, 5911.261092363455, 5949.077892926603, 5376.274202982548, 5379.327584051994, 5384.6769193848495, 5386.192071189274, 5398.055340315429, 6329.905051424233, 6366.713497892606, 6372.203474565679, 6374.808755737336, 6409.327020662763, 5975.9103613446705, 6015.39846015395, 6122.479589234965, 6142.846428839315, 6196.287426945869, 6276.9372306276355, 6387.904181437375, 6396.776112836028, 6407.038944158227, 6409.487241020801, 6113.266408031065, 6128.9693551531955, 6131.049687298476, 6137.754489820357, 6141.969290153521, 6016.308124565731, 6033.0, 6118.162361256354, 6128.319797384666, 6143.877122457615, 6079.787207447718, 6088.665123418077, 6102.786402475892, 6114.205153330038, 6118.20463339763, 5849.502792262535, 6031.306399763907, 6061.909071364022, 6073.301570319293, 6074.301455332693, 5807.0, 5850.356460789395, 5881.794137205177, 5942.702864856654, 5991.850203744942, 6034.577579569388, 6084.60450070744, 6085.0, 6086.969565152146, 6095.725692343944, 5649.067903795828, 5767.106098554731, 5960.642361458326, 5966.134910437875, 5973.193618861398], "unit": "ms", "name": "dojo.html", "value": 5642.074799544346}, {"lowerIsBetter": false, "replicates": [577.7053702611666, 610.8656095658955, 618.7648693496469, 640.1901594482977, 642.9260635026973, 34783.82608086959, 42651.0, 42754.144917101716, 43113.35329970053, 43284.783576082074, 47949.52050479494, 48368.75815620926, 48542.05831766734, 48550.514494855044, 48574.0, 9191.724248272563, 9336.486493242868, 9374.437533747998, 9389.953050234773, 9442.10300021497, 9209.539523023856, 9282.767930801716, 9331.206847417978, 9339.112784285517, 9340.252779777635, 9256.074392560724, 9332.906670933271, 9337.206337461324, 9353.924298705633, 9363.297752668543, 9309.0, 9370.67202647911, 9371.531423428802, 9380.296477764161, 9383.202427793645, 9156.313276504223, 9269.907300926972, 9275.860862087007, 9286.303527235485, 9290.860637090449, 44185.558144418465, 44358.33462498065, 44441.55558444439, 44828.3275750864, 44921.775391122836, 3719.386301260316, 3739.4016957286703, 3818.2554401891643, 3833.5974722654278, 4218.936715949263, 32706.67293327084, 32740.508892366634, 33135.0, 33165.0, 34100.97697069092, 4012.7191096623246, 4052.5136983561865, 4055.452513910643, 4084.9183016339507, 4100.753954762694, 339306.0, 341703.0, 341809.0, 343049.0, 343238.0, 46704.0, 47407.525924741, 47474.0, 47540.762296188295, 69711.65144174246, 45878.770606147424, 45976.77011614921, 46041.76979115083, 46100.7694961523, 46120.077598447846, 17258.13709314529, 17328.393506227472, 17424.12879356027, 17436.389726359517, 17436.825631743774, 14208.147511149364, 14219.431222751182, 14293.070950388399, 14305.427782888568, 14392.712145757236, 16012.359505619877, 16020.0, 16036.198190090448, 16068.75896861548, 16082.839171608368, 6238.844028899314, 6382.63842378323, 6384.744610215539, 6522.34776522344, 6546.345365463416, 1002.734275417015, 1074.8871368506195, 1094.141099237095, 1157.479134389528, 1242.7514497100617, 30319.0, 30852.228694282374, 31070.0, 31621.525677114863, 31724.206894827814, 1126.099120703434, 1144.0904480937675, 1151.0216316131389, 1151.5393842462913, 1250.0749445410513, 15463.149526776135, 15668.68662626764, 15701.0, 15733.606659833596, 16122.274497647633, 443319.0, 523626.0, 536732.0, 539580.0, 542317.0, 67259.66370168216, 68440.0, 68488.0, 68522.0, 68601.0, 1526.3894442222977, 1542.537238828347, 1543.1589783568206, 1545.0575149159004, 1551.612096975756, 33189.668103318654, 33248.833755832035, 33573.0, 33678.32643347168, 34223.97328080161, 52417.0, 52788.736056319474, 52897.206541901134, 53069.20396193983, 53162.4683753173, 327530.0, 331245.0, 332783.0, 333127.0, 334292.0, 36457.63542364542, 37308.440373394966, 37406.438903417016, 37674.62325376711, 37710.81144594259, 48678.51321486881, 49673.50326496689, 49854.0, 50256.24615630695, 50417.0, 41418.1716365665, 41717.0, 41753.0, 42029.36955945724, 42753.86230688515, 41781.79109104435, 41807.581924181584, 42274.0, 42661.78669106634, 42833.357499636906, 42108.789456052524, 42943.141137176455, 43006.0, 43486.782566086964, 43522.69431917048, 35556.466652999705, 35709.46435803413, 36183.0, 36543.45184822283, 37431.43852842155, 28606.42787144204, 28872.711272887, 29096.7090329094, 29103.41793164167, 29158.854205728836], "unit": "ms", "name": "ext.html", "value": 20347.086252950354}, {"lowerIsBetter": false, "replicates": [391.0302449924188, 391.33277761416787, 394.0739262732579, 397.035204453179, 397.05698964958225, 12474.688132796684, 13104.213747175176, 18307.267709291627, 20076.89961550192, 20124.09441575129, 13680.24758638277, 14121.78817317741, 14213.71572568548, 14294.356753946071, 14420.0, 5005.1491246488185, 5147.794088236466, 5149.613778966574, 5158.458361872005, 5244.921326180111, 5212.192110222903, 5272.551833094191, 5330.600204984622, 5334.03987282289, 5340.492653197959, 5296.602754793386, 5312.60155488338, 5321.308229930104, 5323.653962492425, 5543.251661025771, 5502.5597952163735, 5511.22842802008, 5517.862053448655, 5519.448055194489, 5522.447755224485, 4692.085043416535, 4745.525447455227, 4753.33453316536, 4780.1873681474235, 4816.51834816519, 15397.0, 15468.0, 15617.219139043002, 15749.527514174479, 15775.053496790115, 2055.1779288284656, 2155.7305336832897, 2173.815225705817, 2229.710137682107, 2281.5436912617542, 11186.832197517044, 11393.316401015965, 11494.712632184179, 11571.074314054855, 11655.76688466226, 1739.4086010756403, 1778.9110544472724, 1820.2173065581794, 1838.7241913712917, 1857.860660450458, 63553.68223158901, 64209.0, 71310.64344678295, 72338.63830680866, 72829.0, 7861.4103942204565, 7923.12845586985, 8080.757577272691, 8121.26908578219, 8126.146754590801, 9549.045095490395, 9566.56950437232, 9683.41899486033, 9693.369930954465, 9705.466199358962, 6624.238212605515, 6723.5293529452465, 6741.966290168616, 6745.156855393076, 6792.796216113525, 7117.217106118323, 7117.75087871922, 7176.627832748181, 7183.0, 7188.964055179691, 3656.1590834108306, 3732.664060234592, 3753.9436908446396, 3755.4930084438797, 3783.697304215656, 1288.6520639427301, 1304.7194853106437, 1310.8361454818148, 1318.4989703912452, 1360.3878254785386, 470.962323014158, 478.83480199331177, 480.9302651115569, 491.2582001178247, 495.32140966875613, 13376.933115334361, 13732.45070197181, 13740.381682824296, 13845.653858653413, 13992.020558560804, 512.4593553800776, 518.8547206782032, 527.5463101732507, 535.4591862219187, 542.4331573505617, 7430.182679905206, 7435.107787065586, 7562.773116806505, 7701.152873184057, 7785.182555831556, 559600.0, 561213.0, 562483.0, 565886.0, 572010.0, 82585.0, 85518.0, 85924.0, 86087.13912860917, 86364.13635863562, 574.3509833887764, 578.5024878604397, 579.0908274009848, 579.965202087876, 581.0615855393594, 12114.394280285775, 12675.556355527513, 12686.746265074831, 12805.487780488676, 12859.614211573667, 36712.0, 36780.0, 37029.25941481209, 37829.24341513099, 38076.42885356777, 46094.0, 47378.0, 48286.792830179525, 51046.744766277414, 53189.7340513295, 7581.0, 7720.266574675396, 7730.381569474541, 7767.572783496962, 7768.339691126317, 11614.303141811519, 13610.93194534021, 14053.22707251111, 14419.495317663832, 14431.134131952116, 12124.393780310773, 12148.696282593006, 12256.203346782431, 12435.689107772378, 12444.751104978031, 11795.587154449553, 12164.574239901915, 12215.206011609573, 12456.0, 12545.87454125447, 11867.821982670439, 12228.32744199042, 12277.69305767363, 12354.196977196454, 12929.935350323565, 7740.496867703807, 7795.454318197899, 7854.60726963661, 7867.252611001945, 7878.369730421437, 12471.438785254504, 12511.56209532662, 12578.685532861751, 12610.87389126097, 12930.547430839875], "unit": "ms", "name": "jquery.html", "value": 7755.080082923799}, {"lowerIsBetter": false, "replicates": [1525.4432132271718, 1585.4371698047194, 1633.338497908346, 1761.9207135678894, 1859.330640969251, 7785.571793551359, 8055.476394034384, 8083.353331733462, 8124.0, 8333.958330208356, 8336.541490218036, 8360.581970901461, 8391.496510209376, 8435.70475033374, 8510.659573617064, 2463.1502131764555, 2500.8999640014376, 2510.0210917742097, 2512.6859142607173, 2521.2940376694555, 2464.544059349017, 2472.0235506974736, 2487.514934587756, 2489.65144879717, 2491.476789874129, 2400.3519049856527, 2437.6709144265565, 2444.4133407982044, 2446.412860913386, 2463.9137630182945, 2366.95266094678, 2415.734269230392, 2427.5023620157826, 2448.681671382718, 2468.1978357033854, 2481.5161043596504, 2504.0734928076545, 2525.065725681491, 2525.3181640957023, 2538.0, 8228.547429891354, 8290.626921788535, 8313.0, 8321.292690121347, 8336.583170841433, 5118.436971933084, 5191.662541934762, 5218.191180367049, 5231.973840130775, 5232.293640358541, 3338.6494418085995, 3368.0906155338166, 3378.510116033186, 3395.8623861006345, 3408.1309266137223, 1195.3007490618, 1200.7118291610038, 1210.5097435538532, 1229.2685851918095, 1229.7356068445326, 11217.15871309655, 11258.831117533244, 11280.548778048867, 11284.605038823684, 11294.717632059183, 4535.682502224812, 4571.634269258451, 4572.428446444194, 4578.725276483422, 4660.487346391894, 9277.536123193813, 9291.163795258459, 9291.814163716688, 9296.488693121808, 9309.441433513875, 5124.897502050013, 5141.151709967889, 5141.640085194001, 5147.871303217375, 5158.097332966716, 4728.243481043017, 4730.976345118322, 4736.029114031615, 4744.810207591658, 4748.833790817304, 3753.9061523462133, 3842.0971071798103, 3865.43951127085, 3867.4778904847485, 3870.729048966545, 1076.39721755817, 1134.4271143072694, 1151.476078384333, 1160.3038177093676, 1174.9530018799153, 1004.7538353103537, 1111.8721347045032, 1185.7806305833276, 1374.113696665645, 1450.9492167774076, 7510.887336689954, 7568.508046976929, 7592.126905405838, 7595.012648355789, 7605.6957721691615, 764.1829063826113, 789.7828097273295, 795.7572940253278, 796.69725504308, 895.4582477601087, 6221.0, 6292.653904035322, 6294.622322660563, 6308.968455157695, 6323.0, 9621.470819105016, 10095.899041009643, 10103.949480252699, 10127.139193168663, 10147.391156530632, 9784.510774461249, 9787.265955053257, 9820.852687209697, 9839.3112482127, 9941.45322007282, 7109.537880037781, 7151.928480715231, 7158.3557479828105, 7200.243974382719, 7280.563166210044, 7812.570308632852, 7845.960770196112, 7860.0567931848545, 7884.960575197088, 7907.683692652229, 8806.823863522566, 8932.508712020901, 8989.685361012333, 9006.189442950166, 9037.457752534869, 9135.588898499716, 9194.770130746785, 9215.907840921773, 9242.584083716383, 9350.53247337644, 7335.303146201102, 7409.184989651242, 7417.147028091623, 7437.367823735043, 7443.665035073543, 8149.674013039412, 8162.5510596915365, 8256.587170641324, 8259.83480330402, 8274.875876861972, 6574.112494813139, 7490.737824176128, 7621.809454763676, 7676.961615191888, 7804.8829267559895, 7019.333163349474, 7227.891581626385, 7282.708691652275, 7442.0, 7589.203133670885, 7558.811029724301, 7573.507721998052, 7584.658690358837, 7626.54240745557, 7626.771196864103, 6799.694013769294, 6799.762008329685, 6810.148731408574, 6864.313568643295, 6895.103636527219, 7178.712851485882, 7195.38839198653, 7211.71153153868, 7229.49393542468, 7258.3104605062435], "unit": "ms", "name": "mootools.html", "value": 4764.214893594341}, {"lowerIsBetter": false, "replicates": [368.80637665225737, 370.058201876225, 372.0345702900972, 374.7994822769817, 383.36170276489645, 6098.908516372258, 6176.9691151544175, 6213.130161777355, 6252.937470625298, 6263.279722831876, 6033.974224381855, 6079.604825686327, 6109.663968481732, 6132.693365331738, 6133.233345831771, 4687.789049492772, 4694.788734506938, 4713.505081966396, 4716.268978308368, 4730.290456431529, 4732.266498692708, 4739.786709598059, 4749.026449577846, 4762.404699412574, 4765.213739732957, 4678.111158879802, 4696.0, 4740.85777426676, 4750.738709370983, 4759.881002974936, 4684.976575117136, 4716.457607375144, 4730.385049943519, 4735.124002059612, 4755.334253204554, 4176.415301857743, 4181.728187667792, 4181.958180418187, 4188.539260681323, 4189.539150693421, 5789.2763404574425, 5828.271466066742, 5845.795397161079, 5861.9706901465215, 5869.559783016248, 5446.291982042309, 5514.420985796514, 5517.862053448696, 5518.255035570187, 5519.31008623922, 6471.61170329777, 6476.93523064768, 6480.254770701383, 6487.091807147003, 6489.545731798776, 4633.814647414099, 4634.096351211515, 4639.744814035227, 4641.3270075839155, 4643.558861908147, 6629.138212032453, 6630.038644396584, 6663.167104111986, 6688.197416310074, 6736.360045795642, 4696.201645720167, 4712.670113092119, 4723.645726570521, 4735.147673418749, 4735.8342458014495, 4717.599004084691, 4771.6898401603785, 4776.832810851603, 4786.970801277742, 4798.688085274446, 5461.644993075437, 5472.26124473199, 5482.0406428875585, 5493.2034854945805, 5499.862503437366, 6393.328700486475, 6511.186101737283, 6580.506462015368, 6605.966970165118, 6612.140421745238, 1714.4942242038628, 1742.1811748478194, 1742.817004214539, 1759.727242277449, 1765.4615342320715, 1177.2347973816916, 1178.7288923547633, 1180.114913814639, 1181.2144923625692, 1191.2018947305326, 6256.6871656417, 6264.59280146789, 6267.874642507216, 6269.65516896566, 6270.028145637433, 6591.209054913345, 6637.966810165918, 6639.402453779183, 6650.501212409089, 6651.467882569383, 6222.12890195373, 6279.843003924939, 6288.496920246369, 6301.747930082837, 6332.271788744261, 3664.4320130379833, 3681.9815900920858, 3707.5921648618632, 3710.109573702292, 3711.2391959648207, 6840.3501667341525, 6844.726210951606, 6874.209465911485, 6884.65576721162, 6941.375276225164, 6782.2200446948245, 6867.416269617039, 6915.51591388608, 6927.653617319113, 6930.480213983971, 6881.208661003949, 6882.8623427532175, 6907.0, 6917.89623155653, 6923.4807389446, 6646.401823835878, 6671.833204169935, 6714.83212919681, 6728.428083612947, 6732.764353247613, 6618.404343609098, 6663.033860090163, 6668.733250669919, 6674.332566743481, 6708.865822683617, 7061.82345441368, 7070.787876363717, 7077.079979602619, 7081.725289447949, 7086.114235720535, 4768.737719425465, 4815.7351345676325, 4819.156647586588, 4819.855404337875, 4824.589909857701, 6630.972199309115, 6752.08846805675, 6842.144731908512, 6857.862842743018, 6860.176778786577, 6572.7042283098335, 6601.801945941629, 6628.602283862983, 6631.535792494479, 6637.601743895381, 6575.4410875076155, 6585.242697089704, 6594.406503414716, 6598.868022639424, 6599.109120268702, 6414.871702566016, 6442.387973142544, 6472.320406357453, 6474.902876456763, 6490.48076153916, 6647.734090636321, 6698.0, 6704.396604305636, 6713.362230588086, 6724.495662825406, 6508.869822603616, 6509.641969691713, 6514.3811337922825, 6523.706433210612, 6564.113844630913], "unit": "ms", "name": "prototype.html", "value": 4981.294663034694}, {"lowerIsBetter": false, "replicates": [835.9832803343937, 849.172057244187, 948.3314263444272, 949.672363034753, 963.7927845513213, 11610.941945290273, 11720.0, 11744.647660570176, 11749.471273792678, 11798.174127811057, 14114.57656270311, 14231.0, 14236.28818559073, 14247.0, 14274.072185307949, 776.2664282253273, 777.7588947426316, 904.2856143646511, 932.4172392254841, 936.9109934556241, 880.5729221327683, 922.1608336413865, 923.6767131503954, 924.4869097650801, 927.323054170456, 910.0535443139128, 959.366817900186, 961.1974001708581, 964.6527250189926, 966.3718582921123, 909.5997760985146, 937.4515908193681, 941.6610020392619, 942.9905700942971, 945.4138434170858, 695.6417445015821, 700.9614471204081, 703.022798310349, 703.2299631903059, 706.4630880530782, 14879.553613391507, 15011.774823377658, 15016.549503514912, 15040.398384064625, 15049.473268435662, 13636.659083522893, 14091.577252682437, 14494.782578261334, 14717.116972981656, 14749.11505309674, 11353.432328383631, 11561.132915031407, 11709.414529273503, 11716.53133874644, 11778.411079445994, 3982.4026396040827, 3983.6813054955533, 3999.200159968018, 4043.575424580406, 4110.630043296118, 49064.50935490671, 49100.263496047584, 49148.75425622849, 49278.26082608764, 55527.16709249365, 8375.396900092554, 8531.06158322584, 8617.827643447095, 8757.16806903356, 8810.118988101138, 13773.793393099111, 13795.172289662652, 13801.861981380258, 13803.930980345034, 13811.51659691906, 7306.342429181399, 7333.816654583678, 7385.187629360766, 7908.130105688369, 7960.601969901481, 4866.683665561798, 4913.361263035782, 4922.680025798311, 4942.9011419771405, 5015.27278544609, 2883.3656595548946, 2886.4371447567523, 2914.2714321419644, 2915.19832046189, 2916.198045537494, 472.5581581221569, 475.57198521331077, 481.38863643172976, 481.7831975610989, 482.4837423956333, 621.7761605821901, 672.4922683374022, 731.2323649803253, 741.7552207771422, 753.7474945893077, 9082.318826087938, 9334.0, 9456.57445414958, 9478.857817132748, 9497.715068547956, 693.9410150137194, 774.601080443572, 794.1899262751961, 796.494226166377, 807.7495976247382, 4293.935590966138, 4499.122671079173, 4538.341940418687, 4646.651501137429, 4670.486246512881, 64900.35099649037, 65632.67183664051, 65738.0, 69181.3081869175, 69786.65106674434, 60429.39570604326, 60442.39557604455, 60784.0, 61151.0, 61239.0, 55210.447895521334, 55532.16701749477, 55621.16568251399, 55676.72161639166, 56063.71968140133, 9495.097965693249, 9512.571934262836, 9540.141387275178, 9674.322797404115, 9749.951250243703, 40541.39187912125, 42208.15583688371, 42226.09982550854, 42299.57700423079, 43539.56460435482, 53837.46162538324, 54303.0, 55052.0, 55382.72308638592, 55509.167362488784, 8413.915860841558, 9048.954755226181, 9094.681686141217, 9149.77125571866, 9303.813923721624, 12357.32034738062, 12686.555970541356, 12713.42789574453, 12894.548690795777, 13255.734885302047, 12059.095567832272, 12111.394430278628, 12191.085668574715, 12380.62858114258, 12412.503499859904, 11790.351530665552, 11972.281663100242, 12064.396780161132, 12248.75502489963, 12305.0, 12025.699357516132, 12199.878001219875, 12386.442610082388, 12985.675358116123, 13216.273104979318, 10255.07704306616, 10402.427866467417, 10436.321639093434, 10508.054275115277, 10598.576056957943, 9967.950160249153, 10431.68704938853, 10602.151827853908, 10609.310394824312, 10610.363378197333], "unit": "ms", "name": "yui.html", "value": 6729.810950725019}], "name": "dromaeo_css", "value": 7224.648410194309}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 104.0, 109.0, 110.0, 110.0, 119.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [151.0, 122.0, 147.0, 165.0, 126.0, 148.0, 144.0, 123.0, 162.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 160.0, 161.0, 161.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 148.0, 71.0, 71.0, 71.0, 72.0, 153.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 129.0, 88.0, 93.0, 89.0, 135.0, 89.0, 89.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 66.0, 59.0, 59.0, 60.0, 59.0, 72.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.0}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.8}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 83.0, 82.0, 83.0, 81.0, 81.0, 82.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 118.0, 113.0, 120.0, 121.0, 119.0, 120.0, 113.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [143.0, 140.0, 143.0, 139.0, 141.0, 147.0, 150.0, 155.0, 141.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 65.0, 65.0, 67.0, 68.0, 64.0, 63.0, 63.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1486.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.07893020221786], "unit": "score", "name": "Richards", "value": 216.47186399999995}, {"lowerIsBetter": false, "replicates": [170.91095539224065], "unit": "score", "name": "DeltaBlue", "value": 386.85641799999996}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [910.7468123861566], "unit": "score", "name": "RayTrace", "value": 812.5079219999998}, {"lowerIsBetter": false, "replicates": [544.3658138268917], "unit": "score", "name": "Earley", "value": 1224.2925309999998}, {"lowerIsBetter": false, "replicates": [10458.333333333334], "unit": "score", "name": "Boyer", "value": 63.725545816733074}, {"lowerIsBetter": false, "replicates": [23395.3488372093], "unit": "score", "name": "RegExp", "value": 38.938722664015934}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 23527.505375504028}]} 03:24:36 INFO - RETURN: dromaeo_css: 7224.65 03:24:36 INFO - RETURN: kraken: 1486.30 03:24:36 INFO - RETURN: v8_7: 23527.51 03:24:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23527.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1486.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7224.65"}}} 03:24:36 INFO - Return code: 0 03:24:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:24:36 INFO - # TBPL SUCCESS # 03:24:36 INFO - Running post-action listener: _resource_record_post_action 03:24:36 INFO - Running post-run listener: _resource_record_post_run 03:24:37 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 286720; Write bytes: 511713280; Read time: 40; Write time: 479356 03:24:37 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 250757120; Read time: 0; Write time: 335164 03:24:37 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 286720; Write bytes: 260956160; Read time: 40; Write time: 144192 03:24:37 INFO - Running post-run listener: _upload_blobber_files 03:24:37 INFO - Blob upload gear active. 03:24:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:24:37 INFO - Copying logs to upload dir... 03:24:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.639821 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-13 03:24:36.269864) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 03:24:36.273848) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010090 build_url: 'https://queue.taskcluster.net/v1/task/a6jitbrHRN20DG-4d1A0Jg/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-13 03:24:36.325992) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:24:36.326360) ========= 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=3cd289541638898829117e0a000001bd-1449987567.131810-1440514756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-13 03:24:36.376623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 03:24:36.376958) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-13 03:24:36.377337) ========= ========= Total master_lag: 0.26 =========