builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1451647044.89 results: success (0) buildid: 20160101004007 builduid: 91e4adb63f484a9db8b573d18e9c0511 revision: 945377b5fc695e0e57781e20a01001384c4f34af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.887081) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.887561) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.887862) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006428 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.925233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.925526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.945059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:24.945385) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.007907) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.008206) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.008559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.008832) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 03:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-01-01 03:17:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.187319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.187631) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019273 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.240744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.241115) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 945377b5fc695e0e57781e20a01001384c4f34af --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 945377b5fc695e0e57781e20a01001384c4f34af --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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 03:17:25,462 truncating revision to first 12 chars 2016-01-01 03:17:25,462 Setting DEBUG logging. 2016-01-01 03:17:25,462 attempt 1/10 2016-01-01 03:17:25,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/945377b5fc69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 03:17:25,725 unpacking tar archive at: mozilla-aurora-945377b5fc69/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.793492) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.793816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.815281) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.815678) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 03:17:25.816202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-01 03:17:25.816533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --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', '--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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:26 INFO - MultiFileLogger online at 20160101 03:17:26 in /builds/slave/test-pgo 03:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:17:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:17:26 INFO - {'append_to_log': False, 03:17:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:17:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:17:26 INFO - 'branch': 'Mozilla-Aurora', 03:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:26 INFO - 'config_files': ('talos/linux_config.py',), 03:17:26 INFO - 'default_actions': ('clobber', 03:17:26 INFO - 'read-buildbot-config', 03:17:26 INFO - 'download-and-extract', 03:17:26 INFO - 'populate-webroot', 03:17:26 INFO - 'create-virtualenv', 03:17:26 INFO - 'install', 03:17:26 INFO - 'run-tests'), 03:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:26 INFO - 'download_minidump_stackwalk': True, 03:17:26 INFO - 'download_symbols': 'ondemand', 03:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:26 INFO - 'installer_path': 'installer.exe', 03:17:26 INFO - 'log_level': 'info', 03:17:26 INFO - 'log_name': 'talos', 03:17:26 INFO - 'log_to_console': True, 03:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:26 INFO - 'opt_config_files': (), 03:17:26 INFO - 'pip_index': False, 03:17:26 INFO - 'sps_profile': False, 03:17:26 INFO - 'sps_profile_interval': 0, 03:17:26 INFO - 'suite': 'dromaeojs-e10s', 03:17:26 INFO - 'system_bits': '32', 03:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:26 INFO - 'title': 'talos-linux64-ix-031', 03:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:26 INFO - 'use_talos_json': True, 03:17:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:26 INFO - 'work_dir': 'build'} 03:17:26 INFO - ##### 03:17:26 INFO - ##### Running clobber step. 03:17:26 INFO - ##### 03:17:26 INFO - Running pre-action listener: _resource_record_pre_action 03:17:26 INFO - Running main action method: clobber 03:17:26 INFO - rmtree: /builds/slave/test-pgo/build 03:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:17:26 INFO - Running post-action listener: _resource_record_post_action 03:17:26 INFO - ##### 03:17:26 INFO - ##### Running read-buildbot-config step. 03:17:26 INFO - ##### 03:17:26 INFO - Running pre-action listener: _resource_record_pre_action 03:17:26 INFO - Running main action method: read_buildbot_config 03:17:26 INFO - Using buildbot properties: 03:17:26 INFO - { 03:17:26 INFO - "properties": { 03:17:26 INFO - "buildnumber": 61, 03:17:26 INFO - "product": "firefox", 03:17:26 INFO - "script_repo_revision": "production", 03:17:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:17:26 INFO - "repository": "", 03:17:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:17:26 INFO - "buildid": "20160101004007", 03:17:26 INFO - "slavename": "talos-linux64-ix-031", 03:17:26 INFO - "stage_platform": "linux64-pgo", 03:17:26 INFO - "basedir": "/builds/slave/test-pgo", 03:17:26 INFO - "nightly_build": "True", 03:17:26 INFO - "project": "", 03:17:26 INFO - "platform": "ubuntu64_hw", 03:17:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:17:26 INFO - "slavebuilddir": "test", 03:17:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:17:26 INFO - "branch": "mozilla-aurora", 03:17:26 INFO - "repo_path": "releases/mozilla-aurora", 03:17:26 INFO - "pgo_build": "True", 03:17:26 INFO - "builduid": "91e4adb63f484a9db8b573d18e9c0511", 03:17:26 INFO - "revision": "945377b5fc695e0e57781e20a01001384c4f34af" 03:17:26 INFO - }, 03:17:26 INFO - "sourcestamp": { 03:17:26 INFO - "repository": "", 03:17:26 INFO - "hasPatch": false, 03:17:26 INFO - "project": "", 03:17:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:17:26 INFO - "changes": [ 03:17:26 INFO - { 03:17:26 INFO - "category": null, 03:17:26 INFO - "files": [ 03:17:26 INFO - { 03:17:26 INFO - "url": null, 03:17:26 INFO - "name": "https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:17:26 INFO - } 03:17:26 INFO - ], 03:17:26 INFO - "repository": "", 03:17:26 INFO - "rev": "945377b5fc695e0e57781e20a01001384c4f34af", 03:17:26 INFO - "who": "sendchange", 03:17:26 INFO - "when": 1451647005, 03:17:26 INFO - "number": 7408911, 03:17:26 INFO - "comments": "", 03:17:26 INFO - "project": "", 03:17:26 INFO - "at": "Fri 01 Jan 2016 03:16:45", 03:17:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:17:26 INFO - "revlink": "", 03:17:26 INFO - "properties": [ 03:17:26 INFO - [ 03:17:26 INFO - "buildid", 03:17:26 INFO - "20160101004007", 03:17:26 INFO - "Change" 03:17:26 INFO - ], 03:17:26 INFO - [ 03:17:26 INFO - "builduid", 03:17:26 INFO - "91e4adb63f484a9db8b573d18e9c0511", 03:17:26 INFO - "Change" 03:17:26 INFO - ], 03:17:26 INFO - [ 03:17:26 INFO - "nightly_build", 03:17:26 INFO - "True", 03:17:26 INFO - "Change" 03:17:26 INFO - ], 03:17:26 INFO - [ 03:17:26 INFO - "pgo_build", 03:17:26 INFO - "True", 03:17:26 INFO - "Change" 03:17:26 INFO - ] 03:17:26 INFO - ], 03:17:26 INFO - "revision": "945377b5fc695e0e57781e20a01001384c4f34af" 03:17:26 INFO - } 03:17:26 INFO - ], 03:17:26 INFO - "revision": "945377b5fc695e0e57781e20a01001384c4f34af" 03:17:26 INFO - } 03:17:26 INFO - } 03:17:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:17:26 INFO - Running post-action listener: _resource_record_post_action 03:17:26 INFO - ##### 03:17:26 INFO - ##### Running download-and-extract step. 03:17:26 INFO - ##### 03:17:26 INFO - Running pre-action listener: _resource_record_pre_action 03:17:26 INFO - Running main action method: download_and_extract 03:17:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:26 INFO - https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/test_packages.json 03:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/test_packages.json 03:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:17:35 INFO - Downloaded 1302 bytes. 03:17:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:17:35 INFO - Using the following test package requirements: 03:17:35 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:35 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:17:35 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'jsshell-linux-x86_64.zip'], 03:17:35 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:17:35 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:35 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:17:35 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:17:35 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:17:35 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:17:35 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:17:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:17:35 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:17:35 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:17:35 INFO - https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:37 INFO - Downloaded 23025029 bytes. 03:17:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:17:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:17:38 INFO - Return code: 0 03:17:38 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:17: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:17:38 INFO - https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:41 INFO - Downloaded 23025029 bytes. 03:17:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:17:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:17:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:17:43 INFO - Return code: 0 03:17:43 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:17:43 INFO - https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:17:44 INFO - Downloaded 11132038 bytes. 03:17:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:17:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:17:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:17:44 INFO - Return code: 0 03:17:44 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:17:44 INFO - https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:17:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:17:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:17:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:17:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:17:46 INFO - Downloaded 58085732 bytes. 03:17:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:17:46 INFO - mkdir: /builds/slave/test-pgo/properties 03:17:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:17:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:17:46 INFO - Contents: 03:17:46 INFO - build_url:https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - Running post-action listener: set_extra_try_arguments 03:17:46 INFO - ##### 03:17:46 INFO - ##### Running populate-webroot step. 03:17:46 INFO - ##### 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: populate_webroot 03:17:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:46 INFO - '--tppagecycles', 03:17:46 INFO - '7'], 03:17:46 INFO - 'tests': ['tsvgm']}}, 03:17:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:17:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:17:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:17:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['damp', 'tps']}, 03:17:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['damp', 'tps']}, 03:17:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:17:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:46 INFO - 'other': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'other_l64': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'other_nol64': {'tests': ['a11yr', 03:17:46 INFO - 'ts_paint', 03:17:46 INFO - 'tpaint', 03:17:46 INFO - 'sessionrestore', 03:17:46 INFO - 'sessionrestore_no_auto_restore']}, 03:17:46 INFO - 'svgr': {'tests': ['tsvgx', 03:17:46 INFO - 'tsvgr_opacity', 03:17:46 INFO - 'tart', 03:17:46 INFO - 'tscrollx', 03:17:46 INFO - 'cart']}, 03:17:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tsvgx', 03:17:46 INFO - 'tsvgr_opacity', 03:17:46 INFO - 'tart', 03:17:46 INFO - 'tscrollx', 03:17:46 INFO - 'cart']}, 03:17:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'tests': ['tp5o']}, 03:17:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s'], 03:17:46 INFO - 'tests': ['tp5o']}, 03:17:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--xperf_path', 03:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:46 INFO - 'tests': ['tp5n']}, 03:17:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:17:46 INFO - 'talos_options': ['--e10s', 03:17:46 INFO - '--xperf_path', 03:17:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:46 INFO - 'tests': ['tp5n']}}, 03:17:46 INFO - 'talos.zip': {'path': '', 03:17:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - ##### 03:17:46 INFO - ##### Running create-virtualenv step. 03:17:46 INFO - ##### 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: create_virtualenv 03:17:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:17:46 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:17:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:17:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:46 INFO - Using real prefix '/usr' 03:17:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:17:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:48 INFO - Installing pip.................done. 03:17:48 INFO - Return code: 0 03:17:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:17: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:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:17:48 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:17:48 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:17:49 INFO - Using env: {'DISPLAY': ':0', 03:17:49 INFO - 'HOME': '/home/cltbld', 03:17:49 INFO - 'LANG': 'en_US.UTF-8', 03:17:49 INFO - 'LANGUAGE': 'en_US:en', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MAIL': '/var/mail/cltbld', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SHLVL': '1', 03:17:49 INFO - 'TERM': 'linux', 03:17:49 INFO - 'TMOUT': '86400', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - '_': '/tools/buildbot/bin/python'} 03:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:49 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:17:49 INFO - Cleaning up... 03:17:49 INFO - Return code: 0 03:17:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:49 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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:17:49 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:17:49 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:17:49 INFO - Using env: {'DISPLAY': ':0', 03:17:49 INFO - 'HOME': '/home/cltbld', 03:17:49 INFO - 'LANG': 'en_US.UTF-8', 03:17:49 INFO - 'LANGUAGE': 'en_US:en', 03:17:49 INFO - 'LOGNAME': 'cltbld', 03:17:49 INFO - 'MAIL': '/var/mail/cltbld', 03:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:49 INFO - 'MOZ_NO_REMOTE': '1', 03:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:49 INFO - 'NO_EM_RESTART': '1', 03:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:49 INFO - 'SHELL': '/bin/bash', 03:17:49 INFO - 'SHLVL': '1', 03:17:49 INFO - 'TERM': 'linux', 03:17:49 INFO - 'TMOUT': '86400', 03:17:49 INFO - 'USER': 'cltbld', 03:17:49 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:49 INFO - '_': '/tools/buildbot/bin/python'} 03:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:49 INFO - Downloading/unpacking psutil>=0.7.1 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:17:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:17:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:51 INFO - Installing collected packages: psutil 03:17:51 INFO - Running setup.py install for psutil 03:17:51 INFO - building 'psutil._psutil_linux' extension 03:17:51 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:17:51 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:17:51 INFO - building 'psutil._psutil_posix' extension 03:17:51 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:17:51 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:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:51 INFO - Successfully installed psutil 03:17:51 INFO - Cleaning up... 03:17:51 INFO - Return code: 0 03:17:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:17:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:17:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:17:51 INFO - Using env: {'DISPLAY': ':0', 03:17:51 INFO - 'HOME': '/home/cltbld', 03:17:51 INFO - 'LANG': 'en_US.UTF-8', 03:17:51 INFO - 'LANGUAGE': 'en_US:en', 03:17:51 INFO - 'LOGNAME': 'cltbld', 03:17:51 INFO - 'MAIL': '/var/mail/cltbld', 03:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:51 INFO - 'MOZ_NO_REMOTE': '1', 03:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:51 INFO - 'NO_EM_RESTART': '1', 03:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:51 INFO - 'SHELL': '/bin/bash', 03:17:51 INFO - 'SHLVL': '1', 03:17:51 INFO - 'TERM': 'linux', 03:17:51 INFO - 'TMOUT': '86400', 03:17:51 INFO - 'USER': 'cltbld', 03:17:51 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:51 INFO - '_': '/tools/buildbot/bin/python'} 03:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:17:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:17:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:53 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:17:53 INFO - Installing collected packages: mozsystemmonitor 03:17:53 INFO - Running setup.py install for mozsystemmonitor 03:17:53 INFO - Successfully installed mozsystemmonitor 03:17:53 INFO - Cleaning up... 03:17:53 INFO - Return code: 0 03:17:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:17:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:17:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:53 INFO - Using env: {'DISPLAY': ':0', 03:17:53 INFO - 'HOME': '/home/cltbld', 03:17:53 INFO - 'LANG': 'en_US.UTF-8', 03:17:53 INFO - 'LANGUAGE': 'en_US:en', 03:17:53 INFO - 'LOGNAME': 'cltbld', 03:17:53 INFO - 'MAIL': '/var/mail/cltbld', 03:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:53 INFO - 'MOZ_NO_REMOTE': '1', 03:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:53 INFO - 'NO_EM_RESTART': '1', 03:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:53 INFO - 'SHELL': '/bin/bash', 03:17:53 INFO - 'SHLVL': '1', 03:17:53 INFO - 'TERM': 'linux', 03:17:53 INFO - 'TMOUT': '86400', 03:17:53 INFO - 'USER': 'cltbld', 03:17:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:53 INFO - '_': '/tools/buildbot/bin/python'} 03:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:54 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:17:54 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:17:54 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:17:54 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:17:54 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:17:54 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:17:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:17:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17: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:17: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:17: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:17: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:17: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:17: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:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:17:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:17:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:56 INFO - Downloading docopt-0.6.1.tar.gz 03:17:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:17:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:56 INFO - Running setup.py install for blobuploader 03:17:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:17:56 INFO - Running setup.py install for requests 03:17:56 INFO - Running setup.py install for docopt 03:17:57 INFO - Successfully installed blobuploader requests docopt 03:17:57 INFO - Cleaning up... 03:17:57 INFO - Return code: 0 03:17:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:17: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:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:57 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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 03:17:57 INFO - 'HOME': '/home/cltbld', 03:17:57 INFO - 'LANG': 'en_US.UTF-8', 03:17:57 INFO - 'LANGUAGE': 'en_US:en', 03:17:57 INFO - 'LOGNAME': 'cltbld', 03:17:57 INFO - 'MAIL': '/var/mail/cltbld', 03:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:57 INFO - 'MOZ_NO_REMOTE': '1', 03:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:57 INFO - 'NO_EM_RESTART': '1', 03:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:57 INFO - 'SHELL': '/bin/bash', 03:17:57 INFO - 'SHLVL': '1', 03:17:57 INFO - 'TERM': 'linux', 03:17:57 INFO - 'TMOUT': '86400', 03:17:57 INFO - 'USER': 'cltbld', 03:17:57 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:57 INFO - '_': '/tools/buildbot/bin/python'} 03:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:17:57 INFO - Running setup.py (path:/tmp/pip-6u58tm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:17:57 INFO - Running setup.py (path:/tmp/pip-u_ZZpZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:17:57 INFO - Running setup.py (path:/tmp/pip-tqgMvV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:17:57 INFO - Running setup.py (path:/tmp/pip-RCOv9s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:17:57 INFO - Running setup.py (path:/tmp/pip-SrbPa5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:17:57 INFO - Running setup.py (path:/tmp/pip-JKSJo8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:17:57 INFO - Running setup.py (path:/tmp/pip-mUnTgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:17:57 INFO - Running setup.py (path:/tmp/pip-0x3gpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:17:57 INFO - Running setup.py (path:/tmp/pip-gYIpmp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:17:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:17:57 INFO - Running setup.py (path:/tmp/pip-hWntvv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:17:58 INFO - Running setup.py (path:/tmp/pip-zczyV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:17:58 INFO - Running setup.py (path:/tmp/pip-agoQk5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:17:58 INFO - Running setup.py (path:/tmp/pip-XDeDx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:17:58 INFO - Running setup.py (path:/tmp/pip-y11i85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:17:58 INFO - Running setup.py (path:/tmp/pip-hkYylC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:17:58 INFO - Running setup.py (path:/tmp/pip-RNGrRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:17:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:17:58 INFO - Running setup.py (path:/tmp/pip-YJluXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:17:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:58 INFO - Running setup.py install for manifestparser 03:17:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:17:58 INFO - Running setup.py install for mozcrash 03:17:58 INFO - Running setup.py install for mozdebug 03:17:58 INFO - Running setup.py install for mozdevice 03:17:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:17:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:17:58 INFO - Running setup.py install for mozfile 03:17:59 INFO - Running setup.py install for mozhttpd 03:17:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozinfo 03:17:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozInstall 03:17:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozleak 03:17:59 INFO - Running setup.py install for mozlog 03:17:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for moznetwork 03:17:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozprocess 03:17:59 INFO - Running setup.py install for mozprofile 03:17:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozrunner 03:17:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:17:59 INFO - Running setup.py install for mozscreenshot 03:18:00 INFO - Running setup.py install for moztest 03:18:00 INFO - Running setup.py install for mozversion 03:18:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:18:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:00 INFO - Cleaning up... 03:18:00 INFO - Return code: 0 03:18:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:18: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:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:18:00 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:18:00 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:18:00 INFO - Using env: {'DISPLAY': ':0', 03:18:00 INFO - 'HOME': '/home/cltbld', 03:18:00 INFO - 'LANG': 'en_US.UTF-8', 03:18:00 INFO - 'LANGUAGE': 'en_US:en', 03:18:00 INFO - 'LOGNAME': 'cltbld', 03:18:00 INFO - 'MAIL': '/var/mail/cltbld', 03:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:00 INFO - 'MOZ_NO_REMOTE': '1', 03:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:00 INFO - 'NO_EM_RESTART': '1', 03:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:00 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:00 INFO - 'SHELL': '/bin/bash', 03:18:00 INFO - 'SHLVL': '1', 03:18:00 INFO - 'TERM': 'linux', 03:18:00 INFO - 'TMOUT': '86400', 03:18:00 INFO - 'USER': 'cltbld', 03:18:00 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:00 INFO - '_': '/tools/buildbot/bin/python'} 03:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:18:00 INFO - Running setup.py (path:/tmp/pip-ibZInX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:18:00 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:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:18:00 INFO - Running setup.py (path:/tmp/pip-xaJ5TX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:18:00 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:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:18:00 INFO - Running setup.py (path:/tmp/pip-WXEXOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:18:00 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:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:18:00 INFO - Running setup.py (path:/tmp/pip-eTTHo4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:18:00 INFO - Running setup.py (path:/tmp/pip-plaL8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:18:00 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:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:18:00 INFO - Running setup.py (path:/tmp/pip-Uc1y6M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:18:00 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:18:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:18:00 INFO - Running setup.py (path:/tmp/pip-Dv97NP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:18:01 INFO - Running setup.py (path:/tmp/pip-NCCcH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:18:01 INFO - Running setup.py (path:/tmp/pip-Jgqk7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:18:01 INFO - Running setup.py (path:/tmp/pip-3_yjiD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:18:01 INFO - Running setup.py (path:/tmp/pip-npn5ZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:18:01 INFO - Running setup.py (path:/tmp/pip-SgeTBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:18:01 INFO - Running setup.py (path:/tmp/pip-ERbCRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:18:01 INFO - Running setup.py (path:/tmp/pip-csnmw9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:18:01 INFO - Running setup.py (path:/tmp/pip-yN2tMs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:18:01 INFO - Running setup.py (path:/tmp/pip-btuKIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:18:01 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:18:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:18:01 INFO - Running setup.py (path:/tmp/pip-3r6gyN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:18:01 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:18:01 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:18:01 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:18:01 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:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:18:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:01 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:18:03 INFO - Downloading blessings-1.5.1.tar.gz 03:18:03 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:18:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:03 INFO - Installing collected packages: blessings 03:18:03 INFO - Running setup.py install for blessings 03:18:03 INFO - Successfully installed blessings 03:18:03 INFO - Cleaning up... 03:18:03 INFO - Return code: 0 03:18:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:18:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:18:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:18:03 INFO - Reading from file tmpfile_stdout 03:18:03 INFO - Current package versions: 03:18:03 INFO - argparse == 1.2.1 03:18:03 INFO - blessings == 1.5.1 03:18:03 INFO - blobuploader == 1.2.4 03:18:03 INFO - docopt == 0.6.1 03:18:03 INFO - manifestparser == 1.1 03:18:03 INFO - mozInstall == 1.12 03:18:03 INFO - mozcrash == 0.16 03:18:03 INFO - mozdebug == 0.1 03:18:03 INFO - mozdevice == 0.47 03:18:03 INFO - mozfile == 1.2 03:18:03 INFO - mozhttpd == 0.7 03:18:03 INFO - mozinfo == 0.9 03:18:03 INFO - mozleak == 0.1 03:18:03 INFO - mozlog == 3.1 03:18:03 INFO - moznetwork == 0.27 03:18:03 INFO - mozprocess == 0.22 03:18:03 INFO - mozprofile == 0.27 03:18:03 INFO - mozrunner == 6.11 03:18:03 INFO - mozscreenshot == 0.1 03:18:03 INFO - mozsystemmonitor == 0.0 03:18:03 INFO - moztest == 0.7 03:18:03 INFO - mozversion == 1.4 03:18:03 INFO - psutil == 3.1.1 03:18:03 INFO - requests == 1.2.3 03:18:03 INFO - wsgiref == 0.1.2 03:18:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:18: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:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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/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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:18: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/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:18: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/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:18:03 INFO - Using env: {'DISPLAY': ':0', 03:18:03 INFO - 'HOME': '/home/cltbld', 03:18:03 INFO - 'LANG': 'en_US.UTF-8', 03:18:03 INFO - 'LANGUAGE': 'en_US:en', 03:18:03 INFO - 'LOGNAME': 'cltbld', 03:18:03 INFO - 'MAIL': '/var/mail/cltbld', 03:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:03 INFO - 'MOZ_NO_REMOTE': '1', 03:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:03 INFO - 'NO_EM_RESTART': '1', 03:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:03 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:03 INFO - 'SHELL': '/bin/bash', 03:18:03 INFO - 'SHLVL': '1', 03:18:03 INFO - 'TERM': 'linux', 03:18:03 INFO - 'TMOUT': '86400', 03:18:03 INFO - 'USER': 'cltbld', 03:18:03 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:03 INFO - '_': '/tools/buildbot/bin/python'} 03:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 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:18:04 INFO - Cleaning up... 03:18:04 INFO - Return code: 0 03:18:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:18:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:18:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:18:04 INFO - Using env: {'DISPLAY': ':0', 03:18:04 INFO - 'HOME': '/home/cltbld', 03:18:04 INFO - 'LANG': 'en_US.UTF-8', 03:18:04 INFO - 'LANGUAGE': 'en_US:en', 03:18:04 INFO - 'LOGNAME': 'cltbld', 03:18:04 INFO - 'MAIL': '/var/mail/cltbld', 03:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:04 INFO - 'MOZ_NO_REMOTE': '1', 03:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:04 INFO - 'NO_EM_RESTART': '1', 03:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:04 INFO - 'SHELL': '/bin/bash', 03:18:04 INFO - 'SHLVL': '1', 03:18:04 INFO - 'TERM': 'linux', 03:18:04 INFO - 'TMOUT': '86400', 03:18:04 INFO - 'USER': 'cltbld', 03:18:04 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:04 INFO - '_': '/tools/buildbot/bin/python'} 03:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:04 INFO - Downloading/unpacking jsonschema 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:06 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:18:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:06 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:18:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:06 INFO - warning: no files found matching '*.txt' 03:18:06 INFO - no previously-included directories found matching 'build' 03:18:06 INFO - no previously-included directories found matching 'dist' 03:18:06 INFO - no previously-included directories found matching '.git*' 03:18:06 INFO - Installing collected packages: jsonschema, functools32 03:18:06 INFO - Running setup.py install for functools32 03:18:06 INFO - warning: no files found matching '*.txt' 03:18:06 INFO - no previously-included directories found matching 'build' 03:18:06 INFO - no previously-included directories found matching 'dist' 03:18:06 INFO - no previously-included directories found matching '.git*' 03:18:06 INFO - Successfully installed jsonschema functools32 03:18:06 INFO - Cleaning up... 03:18:06 INFO - Return code: 0 03:18:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f026df64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22abeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, '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': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', '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:18:06 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:18:06 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:18:06 INFO - Using env: {'DISPLAY': ':0', 03:18:06 INFO - 'HOME': '/home/cltbld', 03:18:06 INFO - 'LANG': 'en_US.UTF-8', 03:18:06 INFO - 'LANGUAGE': 'en_US:en', 03:18:06 INFO - 'LOGNAME': 'cltbld', 03:18:06 INFO - 'MAIL': '/var/mail/cltbld', 03:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:06 INFO - 'MOZ_NO_REMOTE': '1', 03:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:06 INFO - 'NO_EM_RESTART': '1', 03:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:06 INFO - 'SHELL': '/bin/bash', 03:18:06 INFO - 'SHLVL': '1', 03:18:06 INFO - 'TERM': 'linux', 03:18:06 INFO - 'TMOUT': '86400', 03:18:06 INFO - 'USER': 'cltbld', 03:18:06 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:06 INFO - '_': '/tools/buildbot/bin/python'} 03:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:06 INFO - Downloading/unpacking flake8 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:18:08 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:18:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:18:08 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:18:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 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:18:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:18:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:09 INFO - no previously-included directories found matching 'docs/_build' 03:18:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:18:09 INFO - Running setup.py install for pep8 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:18:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:18:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:18:09 INFO - no previously-included directories found matching 'docs/_build' 03:18:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:18:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:18:09 INFO - Cleaning up... 03:18:09 INFO - Return code: 0 03:18:09 INFO - Running post-action listener: _resource_record_post_action 03:18:09 INFO - Running post-action listener: _start_resource_monitoring 03:18:09 INFO - Starting resource monitoring. 03:18:09 INFO - ##### 03:18:09 INFO - ##### Running install step. 03:18:09 INFO - ##### 03:18:09 INFO - Running pre-action listener: _resource_record_pre_action 03:18:09 INFO - Running main action method: install 03:18:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:18:09 INFO - Reading from file tmpfile_stdout 03:18:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:18:09 INFO - Reading from file tmpfile_stdout 03:18:09 INFO - Output received: 03:18:09 INFO - Usage: mozinstall [options] installer 03:18:09 INFO - Options: 03:18:09 INFO - -h, --help show this help message and exit 03:18:09 INFO - -d DEST, --destination=DEST 03:18:09 INFO - Directory to install application into. [default: 03:18:09 INFO - "/builds/slave/test-pgo"] 03:18:09 INFO - --app=APP Application being installed. [default: firefox] 03:18:09 INFO - mkdir: /builds/slave/test-pgo/build/application 03:18:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:18:24 INFO - Reading from file tmpfile_stdout 03:18:24 INFO - Output received: 03:18:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:18:24 INFO - Running post-action listener: _resource_record_post_action 03:18:24 INFO - ##### 03:18:24 INFO - ##### Running run-tests step. 03:18:24 INFO - ##### 03:18:24 INFO - Running pre-action listener: _resource_record_pre_action 03:18:24 INFO - Running main action method: run_tests 03:18:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:18:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:18:24 INFO - Python 2.7.3 03:18:24 INFO - Return code: 0 03:18:24 INFO - grabbing minidump binary from tooltool 03:18:24 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:18:24 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 0x22a9290>, '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 0x22a9f90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22aa420>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:18:24 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:18:24 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:18:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:24 INFO - Return code: 0 03:18:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:18:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:18:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:18:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:18:25 INFO - Return code: 0 03:18:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 03:18:25 INFO - Using env: {'DISPLAY': ':0', 03:18:25 INFO - 'HOME': '/home/cltbld', 03:18:25 INFO - 'LANG': 'en_US.UTF-8', 03:18:25 INFO - 'LANGUAGE': 'en_US:en', 03:18:25 INFO - 'LOGNAME': 'cltbld', 03:18:25 INFO - 'MAIL': '/var/mail/cltbld', 03:18:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:18:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:25 INFO - 'MOZ_NO_REMOTE': '1', 03:18:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:25 INFO - 'NO_EM_RESTART': '1', 03:18:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:18:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:18:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:18:25 INFO - 'SHELL': '/bin/bash', 03:18:25 INFO - 'SHLVL': '1', 03:18:25 INFO - 'TERM': 'linux', 03:18:25 INFO - 'TMOUT': '86400', 03:18:25 INFO - 'USER': 'cltbld', 03:18:25 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741', 03:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:25 INFO - '_': '/tools/buildbot/bin/python'} 03:18:25 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/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 03:18:25 INFO - mozversion INFO | application_buildid: 20160101004007 03:18:25 INFO - mozversion INFO | application_changeset: 945377b5fc695e0e57781e20a01001384c4f34af 03:18:25 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:18:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:25 INFO - mozversion INFO | application_name: Firefox 03:18:25 INFO - mozversion INFO | application_remotingname: firefox-dev 03:18:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:25 INFO - mozversion INFO | application_vendor: Mozilla 03:18:25 INFO - mozversion INFO | application_version: 45.0a2 03:18:25 INFO - mozversion INFO | platform_buildid: 20160101004007 03:18:25 INFO - mozversion INFO | platform_changeset: 945377b5fc695e0e57781e20a01001384c4f34af 03:18:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:18:25 INFO - mozversion INFO | platform_version: 45.0a2 03:18:25 INFO - 2016-01-01 03:18:25,423 DEBUG : using testdate: 1451647105 03:18:25 INFO - 2016-01-01 03:18:25,423 DEBUG : actual date: 1451647105 03:18:25 INFO - 2016-01-01 03:18:25,516 INFO : starting webserver on 'localhost:33412' 03:18:25 INFO - 2016-01-01 03:18:25,517 INFO : Starting test suite talos-linux64-ix-031.e 03:18:25 INFO - 2016-01-01 03:18:25,517 INFO : Starting test dromaeo_css 03:18:25 INFO - 2016-01-01 03:18:25,518 DEBUG : operating with platform_type : linux_ 03:18:25 INFO - 2016-01-01 03:18:25,518 INFO : Initialising browser for dromaeo_css test... 03:18:25 INFO - 2016-01-01 03:18:25,535 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGEz0WW/profile http://localhost:33412/getInfo.html 03:18:29 INFO - 2016-01-01 03:18:29,967 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:18:29 INFO - 2016-01-01 03:18:29,967 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:18:29 INFO - 2016-01-01 03:18:29,967 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:18:29 INFO - 2016-01-01 03:18:29,967 DEBUG : BROWSER_OUTPUT: __metrics 03:18:30 INFO - 2016-01-01 03:18:30,921 INFO : Browser initialized. 03:18:30 INFO - 2016-01-01 03:18:30,922 INFO : Running cycle 1/1 for dromaeo_css test... 03:18:30 INFO - 2016-01-01 03:18:30,922 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGEz0WW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:18:42 INFO - 2016-01-01 03:18:42,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 136863744 03:18:42 INFO - 2016-01-01 03:18:42,758 DEBUG : BROWSER_OUTPUT: 03:19:32 INFO - 2016-01-01 03:19:32,361 DEBUG : BROWSER_OUTPUT: 1451647172359 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:21:40 INFO - 2016-01-01 03:21:40,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33412/tests/dromaeo/cssquery-ext.html) 03:21:41 INFO - 2016-01-01 03:21:41,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 140509184 03:21:41 INFO - 2016-01-01 03:21:41,328 DEBUG : BROWSER_OUTPUT: 03:24:43 INFO - 2016-01-01 03:24:43,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-ext.html (next: http://localhost:33412/tests/dromaeo/cssquery-jquery.html) 03:24:43 INFO - 2016-01-01 03:24:43,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 139341824 03:24:43 INFO - 2016-01-01 03:24:43,663 DEBUG : BROWSER_OUTPUT: 03:27:45 INFO - 2016-01-01 03:27:45,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33412/tests/dromaeo/cssquery-mootools.html) 03:27:45 INFO - 2016-01-01 03:27:45,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 140578816 03:27:45 INFO - 2016-01-01 03:27:45,795 DEBUG : BROWSER_OUTPUT: 03:30:47 INFO - 2016-01-01 03:30:47,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33412/tests/dromaeo/cssquery-prototype.html) 03:30:47 INFO - 2016-01-01 03:30:47,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 139259904 03:30:47 INFO - 2016-01-01 03:30:47,984 DEBUG : BROWSER_OUTPUT: 03:33:50 INFO - 2016-01-01 03:33:50,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33412/tests/dromaeo/cssquery-yui.html) 03:33:50 INFO - 2016-01-01 03:33:50,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 03:33:50 INFO - 2016-01-01 03:33:50,839 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/dromaeo/cssquery-yui.html (next: http://localhost:33412/tests/dromaeo/cssquery-dojo.html) 03:36:53 INFO - 2016-01-01 03:36:53,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 03:36:53 INFO - 2016-01-01 03:36:53,334 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3369.747268954828;3405.3359594878993;3409.5908490981087;3441.5698037745283;3447.0520606833124;5525.088360420531;5547.500724934755;5563.026470367689;5573.136163894597;5575.330960284767;5525.4474552544725;5618.185363122345;5643.915341269874;5647.915281270774;5694.800681976131;5073.822416215442;5152.072626927152;5176.12005958986;5193.272941788153;5229.947700522984;5065.7467126643705;5126.641135120543;5138.203578445328;5212.4266330703595;5252.6323157379;5133.204353325222;5201.167813149897;5201.531862132426;5203.089459344618;5225.163973764198;5158.458361871987;5259.474052594748;5280.419153893069;5286.762095705702;5292.417834038291;4935.0376676548085;4953.975230123862;5003.5997120230295;5155.871103222412;5170.353705786777;5389.8113566025;5460.7542660579975;5468.64453810505;5478.972605136989;5479.589030822704;6048.334683184846;6061.818145455643;6084.6045007074845;6102.572819902609;6106.786262480836;5894.734736936848;6021.458068773832;6068.939310606882;6142.140100385949;6177.567570270083;5649.406812284733;5702.059160238556;5706.71466426677;5726.169705392736;5730.36965933747;6192.690365481708;6199.814005579839;6205.317415084337;6214.875702486015;6219.346968568326;5765.596408251466;5855.268091488564;5882.617629854046;5956.821295361146;5988.6706231157705;6028.849278767978;6094.939050609526;6130.1724267224245;6170.352113028157;6172.135900973867;5901.114832775118;6073.726682299307;6142.600730952474;6147.44672979434;6160.537959653044;5946.702664866826;6022;6090.543209259324;6118.908216376758;6127.509799216052;4568.908621827545;4611.123886461562;4648.1168577970075;4662.300654901792;4665.206914824488;4053.0475338296064;4129.504459464823;4206.3690446432665;4211.957880421157;4252.851150209728;5819.330776960619;5878;5906.173135760997;5920.082387229986;5928.081147422156;6160.168377269011;6174.413430724074;6178.196834411498;6180.443760061616;6187.102870083902;5625.268715067015;5626.549876009991;5727.31272247333;5893.233879595625;5902.675352855548;5092.2361645753435;5112.71880046601;5137.17805151174;5151.407588127338;5160.225966105114;6178.814635560941;6225.128482012522;6249.500039996789;6256.906146407808;6260.780872669526;5899.174115623902;6057.939420605738;6087.634741915499;6135.478484328793;6153.384661533811;6217.751289948352;6294.968525157345;6307.36926307384;6334.619922804646;6336.936630633634;6081.118237855575;6094.786682466092;6103.23709536308;6119.632822030692;6123.877522449615;5921.348651648402;6019.879602408015;6113.816585502442;6179.320274769681;6213.813585592439;5987.43119403656;5992.910106348321;5993.910091348546;5998.970005150121;6015.428534289235;5921.526277897672;5956.315023772322;5970.9701451492465;5980.401959803985;5980.760769569169;5660.801871934463;5775.595708300547;5837.29952405714;5874.911876321944;5935.940640593712;5930.881382372415;6037.18498002764;6080.543959202989;6109.908351374644;6114.205153330038;5614.803481878114;5931.169636250842;5939.732712027882;5942.376050514634;5960 03:36:53 INFO - 2016-01-01 03:36:53,335 DEBUG : BROWSER_OUTPUT: |1;ext.html;604.6372176693984;609.9390060993901;636.4717284653738;652.5269179844611;663.3002182697254;31339.373212535735;31984.36031279376;37024.814875925615;37746.24507509848;37919.81040094796;39473.60526394735;39515.60484395155;39749.40375894364;39835;39966;9118.726438206848;9244.029376915429;9244.722658320261;9248.398854074498;9280.257579393632;9000.639974401016;9107.544622768868;9117.45295282282;9128.863067053966;9171;9030.50332231727;9127.406718563305;9159.22146617535;9160.45037297761;9162.862557061617;9066.954665226665;9119.908800911971;9125.315601329927;9163.35856490046;9183.770405739842;8845.646174153026;9060;9078.364514483988;9079.092090790935;9089;41388.793056034825;41892.3716144255;41918;41934.58065419337;42090.1581968362;3556.324298383299;3621.4205727083804;3716.832742526593;3783.8486460541544;4007.699422543321;31987.6801231987;32000;32000.679993200003;32141.839290803397;32620.836895815606;4168.874933751992;4364;4366.061296821199;4368;4370.169667763146;251267.74366128235;251543;251562;251913;251989;44267.55732442699;44428.3335749964;44430.55569444264;44776.3283550747;44857.775711121234;41981.79009104935;42333.788331058764;42430.78784606057;42454.57545424506;42468.150636987084;14499.420023198954;14551.126932384092;14586.4894728684;14624.049436786574;14628.926855365655;11425.428728563538;11551.249168804;11556.306621602731;11582.47878845454;11776.94111529454;15170.469033583771;15259.313330900137;15288.312025958636;15297.847021529642;15393.769093463607;6081.817545473555;6103.572749907553;6117.449429551361;6146.7233974471255;6161.44546990773;1008.4302369161401;1102.0522350778324;1109.0074383426788;1121.1647322744445;1225.650689553473;27371.452570948866;27377.726222737918;27471;27606.0337888177;27622.861885690443;1127.7406196574834;1143.4168574027306;1178.4049055227056;1184.8992835608897;1247.2391840976998;14668.413263469554;14669.633259168606;14886.70226595462;14941.327640255997;15014.624634384008;421145;770866;801876;805258;810668;57551.424485755444;57931.71034144887;58548.41451585515;58580;58582.70708646515;1381.1367895065584;1472.4331132513846;1490.69440764643;1501.8122734658168;1509.0794615284667;30036;30427.695723042485;30574.388512230074;31347.05958821239;31379;47082;47428;47558.52441475541;47650;47694.761526192146;309245;310577;311897;312257;312764;33171;49023.50976490189;49351.50648493613;49668.503314967835;49871;43856.56143438525;44523;45133;45247.09505809931;45439.091218176116;38399.616003839605;39160.60839391684;39384.80307598443;39508.802455987534;40317.59682403138;38604.22791544097;38646.806765965994;39051.2189756209;39183.41224881686;39190.216195675355;43417.131657366044;43446.56553434425;43532.12935741204;43938.34092488679;44538.777306114556;33236.667633323355;33447.83276083604;34162.14594635154;34165.65834341724;34213.31573368568;26482.470350593267;27095.72904271011;27309.86345068262;27469;27518.449631006868 03:36:53 INFO - 2016-01-01 03:36:53,339 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.7171107524894;391.4304686680879;391.60643553229;393.39024512006387;394.439895348605;16569;16832;18158.909205453972;18163.72754408685;18496.630067398644;18213.63572728548;18232.72650910234;18317.084145792724;18672.159752811123;18705.62588748224;5141.897162056747;5259.368875734917;5267.76295066721;5268.973655131738;5274.92087618686;5261.76322065508;5715.485606295432;5849.356570777232;5896.262967129109;5910.822675319726;5820.912686309709;5822.679752613604;5824.068149096145;5832.650040997532;5886.293644762634;6082.787102451415;6397.296297407282;6402.839929001766;6408.51936104794;6435.806925792233;5503.669779813224;5685.943140568624;5719.7140142992685;5722.9984752668115;5743.798967036176;13828;13847.515336963259;13886.236257005861;16078.437254696146;22119.44701382478;2189.179057853305;2197.769234230415;2251.1445650652813;2264.9886750566143;2313.306008197551;10616.734581635445;10716.678499645022;11063;11281.943590281997;14602.050866693631;1921.2315073970383;1927.6144771045847;1953.9413817585496;2007.5081605006721;2009.1561544151346;63335.68332158356;64026.67986660083;64907;65780.99999999952;66458.66770666164;11060;11123.833142502868;11165.385903775208;11178.944105279421;11194.608188713519;14748.926255368655;14750.778738318933;14752.114873107648;14819;14849;7999.1600881907725;8033.839323213503;8040.839183216303;8059.556724380215;8110.5539195343645;7789.688412463552;7796.181400952818;7809.297163255334;7822.765317040498;7823.921760782433;4753.382060332135;4825.879353016133;4845;4851.733154676526;4881.975590122098;1912.722655214986;2013.7281467001767;2021.7472815898013;2045.4681782736297;2071.6892466130203;1085.0288991352695;1118.3290025984345;1122.910167186623;1124.1961997172061;1132.4790596325784;15938.36246550125;16018.599535011717;16691.165441728106;16831.663366732595;17949.910250448665;1031.6698656430021;1035.5909415780875;1050.112654806687;1084.0378914165228;1088.684281558355;9449.43303401798;9535.2371810255;9716;9728.659496917573;10364.170866330676;651010;655458;662022;685590;693508;81486.33311500997;82891.5855420719;83640;85103.14896851077;85145;1135.73310272086;1138.3966497756203;1151.5566506894738;1177.2995067934564;1224.908131890112;15636.765448518054;16067.598310042342;16159.596010099842;16460.176991150154;16578.253978571236;33778.3244335107;33867.15332116717;34208.82895585506;36911.26177476489;38016.619833801306;44539.331910022025;45704.31443528416;46826.76586617045;46843.53156468528;47122.52877471181;10067.395956242648;10568.788624227625;10701.678949631523;10725.195610329412;10868.836967445337;12447.253164810141;16857.831421686118;17490.650186996445;17841.553961150556;18297.176627051547;15122.877122877122;15344;15485.612859678598;15596.84403155954;16172;14678.339474723876;14996;15054.397824087351;15720.371185152922;15905.602359941095;15221.31504082341;15276;15356.155411452477;15500;15882.285297161887;9841.85237221428;10155.543000564845;10255.230857685852;10438.37369757817;10644.574217031543;10339.276250662382;10622.628208012682;10624.203184761329;10860.837087443537;15241.237938103272 03:36:53 INFO - 2016-01-01 03:36:53,339 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1567.9764803527946;1602.0122471590487;1631.9347226110956;1804.6661367646986;1876.2119909637943;8001.679932802688;8263.33893288537;8445.957770211156;8513.957430212848;8554.40119191656;8448.408611397204;8475;8515.19105684959;8524.8721269181;8552.486850788957;2405.1581946318825;2424.9151279705216;2440.2069327468644;2440.9755902441016;2446.5106978604263;2455.938601534967;2476.554220240356;2478.863662498562;2486.17956074495;2512.1648745162665;2372.240882917467;2379.2862141357523;2383.2254517281954;2402.3513651314133;2418.3349578865864;2336.3224664847176;2383.9284821455385;2439.329184474257;2441.682581264442;2444.0590372706456;2444.083468699238;2460.8769561521854;2472.2336075816556;2476.616124500705;2483.639872218518;8231.794205144859;8312.085670576233;8331.458455200393;8348.833023339559;8379.748607541784;4990.351254336949;5072;5079;5086.669366491166;5163.535281824654;3194.4250034993693;3194.536792165123;3194.8242846643425;3225.7741958062943;3234.91912702182;1037.6160820496389;1048.64346122318;1056.3082870018443;1082.44795154471;1089.782043591285;11394.25937314072;11427.371494567795;11447;11456.828147577793;11482.65552033432;4343.109662519176;4360.934585981213;4365.585269399402;4472.731636101845;4486.910261794811;9307.72076837696;9320.95339523298;9334.39326443779;9352.532373381304;9357.90642093584;4988.6009119270375;5044.369453818273;5046.722430266297;5050.747462626854;5064.265681476165;4555.9772201138785;4576.748278844629;4601.700889442242;4622.791974361162;4631.305304204329;3631.9636803631624;3711.888643340704;3725.590185079639;3729.1236559408517;3750.5686846012513;1114.7603265298;1122.4499995002552;1129.0403157316216;1134.325076579434;1209.9957035660382;983.3804703037041;989.1789814453986;1013.1692012549638;1184.7393573413835;1478.6155599544195;7839.490433121829;7953.761387158394;7957.6021198939825;8019.278264956065;8039.598020099089;1158.1661203933154;1172.7654469106042;1173.0556901694217;1190.3750530971308;1193.7612477504533;6055.757769689163;6105.175801266772;6106.755729770848;6167.599106058092;6195.907061394083;9947.104760571583;10045.648402305884;10101.444420556792;10106.595736170471;10170.135538479164;9144.771380715401;10004.899951000543;10034.598616055277;10064.396136231702;10151.1371533419;7739.651715672809;7804.453688241769;7824.843503129906;7845.333146682482;7915;7653.961730191313;7704.422168337509;7785.571793551409;7821.374290056896;7827.491213071132;8579.442336248374;8598.65605375803;8616.827663446822;8766.474011559327;8807.031226565201;8847.690330838648;8995.505247211466;9013.684521041732;9171;9252.537373131181;7477.252274772479;7477.962610187132;7555;7556.508826926232;7559.357454616419;7967.700655708608;8083.110857805519;8112.959435202786;8134.227248411392;8134.796630084295;6598.175228096488;7529.134149572869;7620.618969051415;7675.3475954542255;7704.114026886979;7223.530470519399;7271.3455788979245;7338.082739657543;7364.153122390993;7485.401167906663;7490.70037198506;7578.355839753683;7581.166071732216;7591.810204744926;7594;6752.189737231563;6880.931190688029;6899.379055884994;6906.136732908387;6909.689063992032;6986.930130698628;7013.368796808311;7030.824229394306;7055.118110236221;7059.611721355374 03:36:53 INFO - 2016-01-01 03:36:53,339 DEBUG : BROWSER_OUTPUT: |4;prototype.html;365.7129153614412;371.0871256708497;372.74466990111756;373.29819938515595;375.04176828203947;6347.333529979355;6427.068075129109;6471.9352806471925;6496.187976502937;6497.805065848021;6217.253929528463;6394.6482943438095;6397.1683681121385;6397.904031439532;6420.518461115424;4947.727874966876;4952.034353301099;4958.033183529214;4959.206526955688;4966.801327946878;4960.702357858522;4965.0069986002945;4969.006198760244;4979.825706100287;4985.950140498603;4824.204006338968;4917.606591472673;4964.379452568429;4984.978079493713;4987;4892.14387482191;4897.142999975008;4912.754362281889;4972.701637901738;4975.278584605248;4387.583179597933;4400.11997600478;4408;4415.293553031532;4418.072204836988;5989.13157592151;6123.785667501616;6143.354947730513;6150.784722534735;6156.322804491547;5823.854403639901;5833.679147646878;5840.182374467578;5846.152307915371;5857.648541087548;6903.206131294915;6904.4821638377325;6910.896336554955;6918.688659010357;6935.549189302729;4893.804247830082;4898.5591296783105;4900.926486102711;4903.975480122613;4912.459629440758;6882.621455819928;7097.112860892388;7129.7861064168155;7142.642867856586;7157.427405807575;5017.874553136201;5020.698758074527;5022.271770593244;5031.295618613397;5041.949580504222;5089.770960306795;5091.821786237464;5101.923471147936;5108.386993560796;5113;5721.971390143022;5810.157527158538;5812.418758124154;5814.30228372598;5818.330891947396;6913.654317284116;6917.688704008332;6920.273371296042;6923.411510021604;6936.09830722013;1759.6216813385183;1782.8930264184191;1794.2105473591578;1795.0396537852187;1796.1737600703561;1210.074293165729;1222.443788076423;1242.8508578970582;1250.8061250506187;1252.5365614722612;6526.118973938457;6621.172353455818;6630.9668451657435;6648.135742353463;6650.600963942179;7023.508354415244;7062.223155452896;7074.151101867808;7081.327273908971;7086.893696594555;6499;6596.96701516499;6609.438197753148;6616.768413105518;6636.900446493307;3792.886213413602;3843.557990831034;3846.1730727893078;3846.8461261549783;3854.8628154694434;7180.102487189101;7182.138143422718;7206.9549915262;7215.96392018047;7228.060352154292;7097.858042839218;7122.180949190806;7197.748078817216;7204.9639751800905;7235.96382018097;7179.784606461814;7182;7184.425245980414;7190.173130090002;7198.568085914757;7013.263607321362;7063.081799366049;7069.752558660422;7075.575465471882;7078.964605176941;6847.417969472452;6908.240093589801;6962.303769622998;6967.338102880219;6971.5468494547695;7138.39323657495;7204.603746793977;7204.747833825791;7205.639718014183;7218.602976836324;4991.775370108281;5025.698458092526;5034.546890779701;5050.318207042149;5054.241863720471;6938.895916561357;6994.985727069445;7058.164877132085;7135.643217838983;7207.639618019183;6938.306169383223;6966.059581956371;6968.965155174192;6992.16094068715;6995.685194166173;6926.272741362084;6930.688119034757;6933;6933.5493192942295;6946.409555187865;6698.933010669831;6859.485538584726;6864.622445765531;6873.243943166148;6877.58734475933;6992.265812089658;6998.930010700032;7012.053372794811;7024.929750702428;7044.682989265598;6711.865762684816;6805.693743781443;6824.488163387865;6852.657367131524;6853.828654283683 03:36:53 INFO - 2016-01-01 03:36:53,340 DEBUG : BROWSER_OUTPUT: |5;yui.html;914.2000749344323;927.5315965437455;943.5470973932516;943.6649989253815;947.0813311088242;14160.57518274451;14427.567172984802;14499.420023199073;14503.419863205472;14556.05385649932;13804.171749695026;13856.515021974234;13899.79150312746;13901.513447029356;13938.721225575482;729.3873146556891;740.9073865766779;875.483464755794;899.7525680437899;912.1471424218344;893.2407453664398;893.8346405914926;894.8568229083348;896.3456676626067;898.1602201941173;935.0555938502127;937.690562114504;941.1388579449796;944.773254418938;946.2146418472686;939.7650587353128;940.9811803763921;941.5010044676333;942.5475771629656;943.7640589852537;685.0888318536385;687.5084314715003;690.2234985641154;692.3076923076923;694.9478789090839;14000.509982150576;14005;14082.577522674335;14092.154470731788;14102.71794564103;11898;12856.678583035406;12942.805857912139;13281.785065560249;13634.93182534091;10750.462476876124;10839;11000.889991100066;11013.449327533672;11022.944885275523;3714.628537146291;3732.2908647356917;3752.0994961209385;3793.7723736575617;3830.731848770587;47289;47387.76306118482;47442.76278618619;47697.76151119222;48807.26789098166;10287.639932602324;10795.6221532246;10964.451777411257;11005.944970275097;11027.676678798434;19062.523436914187;19094.904525477283;19130.234790608498;19144.808551914302;19208.71186932197;7982.042154941328;8048.476849004796;8136.349092072738;8170.387220958333;8276.627551760184;4399.626031787334;4493.505714371417;4499.52754960731;4534.297183936429;4618.0994706032;3303.042117785815;3332.9333413331597;3361.3445378151514;3365.1418888183357;3379.729621630264;602.4999250621973;611.0437165835542;616.4236438929615;616.4513582911212;623.6320570863122;728.6538894025401;742.2280827938883;746.0823187479431;753.3596443023496;753.8982237397881;8884.555772211494;9175.541222938826;9331.486768227813;9383.953080234554;9489.525523723787;586.1617886422457;650.5771248688391;683.2586643491867;694.1496666583395;698.9615571143535;4193.619230154949;4451.955480445219;4587.770611469413;4623.375844261049;4629.560191781776;52867;52868;53118.468815312124;53157.2026419604;60637;47821.76089119602;48426.75786621044;48839;48877.77805554819;49631.50368496341;48950.75524622425;49170;53180.73409632927;53345.733271333396;53539.464605354224;9387.202087822612;9570.617175313188;9595.90404095978;9746.31775775689;9894.802103957736;34743.65256347505;35047.47428788621;35107.824460877535;35809.64190358063;36040.27919441649;44008.779956100014;46472;49516.75241623769;49606.25590616216;49744.75127624339;11012.779744405227;11886;12110.152289339661;12201.389930503618;12219.511219551474;13448.932755336553;13505.12216705911;13589;13974.021818473017;14334.784978225543;12556.37218139071;12959.740805184032;13210.801837972245;13229.735405291647;13388.732225355634;12848.35758212067;12992.155509891827;13464.326783660974;13637.454501820213;13767.655808604864;11872.465739041936;12441.253524788543;12635.494580216688;12835.294058826854;13482.595522134352;10638.89361106379;10945;11067;11142.610008649659;11445.656630301104;10757.838632420364;10800.24398292112;10976.670699879016;11081.50133244022;11133 03:36:53 INFO - 2016-01-01 03:36:53,340 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:36:53 INFO - 2016-01-01 03:36:53,340 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:36:53 INFO - 2016-01-01 03:36:53,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: __startTimestamp1451648213331__endTimestamp 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,341 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5646.43 Median:5902.68 stddev:637.52 (10.8%) stddev-sans-first:613.94 03:36:53 INFO - 2016-01-01 03:36:53,342 DEBUG : BROWSER_OUTPUT: Values: 3369.7 3405.3 3409.6 3441.6 3447.1 5525.1 5547.5 5563.0 5573.1 5575.3 5525.4 5618.2 5643.9 5647.9 5694.8 5073.8 5152.1 5176.1 5193.3 5229.9 5065.7 5126.6 5138.2 5212.4 5252.6 5133.2 5201.2 5201.5 5203.1 5225.2 5158.5 5259.5 5280.4 5286.8 5292.4 4935.0 4954.0 5003.6 5155.9 5170.4 5389.8 5460.8 5468.6 5479.0 5479.6 6048.3 6061.8 6084.6 6102.6 6106.8 5894.7 6021.5 6068.9 6142.1 6177.6 5649.4 5702.1 5706.7 5726.2 5730.4 6192.7 6199.8 6205.3 6214.9 6219.3 5765.6 5855.3 5882.6 5956.8 5988.7 6028.8 6094.9 6130.2 6170.4 6172.1 5901.1 6073.7 6142.6 6147.4 6160.5 5946.7 6022.0 6090.5 6118.9 6127.5 4568.9 4611.1 4648.1 4662.3 4665.2 4053.0 4129.5 4206.4 4212.0 4252.9 5819.3 5878.0 5906.2 5920.1 5928.1 6160.2 6174.4 6178.2 6180.4 6187.1 5625.3 5626.5 5727.3 5893.2 5902.7 5092.2 5112.7 5137.2 5151.4 5160.2 6178.8 6225.1 6249.5 6256.9 6260.8 5899.2 6057.9 6087.6 6135.5 6153.4 6217.8 6295.0 6307.4 6334.6 6336.9 6081.1 6094.8 6103.2 6119.6 6123.9 5921.3 6019.9 6113.8 6179.3 6213.8 5987.4 5992.9 5993.9 5999.0 6015.4 5921.5 5956.3 5971.0 5980.4 5980.8 5660.8 5775.6 5837.3 5874.9 5935.9 5930.9 6037.2 6080.5 6109.9 6114.2 5614.8 5931.2 5939.7 5942.4 5960.0 03:36:53 INFO - 2016-01-01 03:36:53,342 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,342 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57759.46 Median:39632.50 stddev:130886.01 (330.2%) stddev-sans-first:131182.84 03:36:53 INFO - 2016-01-01 03:36:53,342 DEBUG : BROWSER_OUTPUT: Values: 604.6 609.9 636.5 652.5 663.3 31339.4 31984.4 37024.8 37746.2 37919.8 39473.6 39515.6 39749.4 39835.0 39966.0 9118.7 9244.0 9244.7 9248.4 9280.3 9000.6 9107.5 9117.5 9128.9 9171.0 9030.5 9127.4 9159.2 9160.5 9162.9 9067.0 9119.9 9125.3 9163.4 9183.8 8845.6 9060.0 9078.4 9079.1 9089.0 41388.8 41892.4 41918.0 41934.6 42090.2 3556.3 3621.4 3716.8 3783.8 4007.7 31987.7 32000.0 32000.7 32141.8 32620.8 4168.9 4364.0 4366.1 4368.0 4370.2 251267.7 251543.0 251562.0 251913.0 251989.0 44267.6 44428.3 44430.6 44776.3 44857.8 41981.8 42333.8 42430.8 42454.6 42468.2 14499.4 14551.1 14586.5 14624.0 14628.9 11425.4 11551.2 11556.3 11582.5 11776.9 15170.5 15259.3 15288.3 15297.8 15393.8 6081.8 6103.6 6117.4 6146.7 6161.4 1008.4 1102.1 1109.0 1121.2 1225.7 27371.5 27377.7 27471.0 27606.0 27622.9 1127.7 1143.4 1178.4 1184.9 1247.2 14668.4 14669.6 14886.7 14941.3 15014.6 421145.0 770866.0 801876.0 805258.0 810668.0 57551.4 57931.7 58548.4 58580.0 58582.7 1381.1 1472.4 1490.7 1501.8 1509.1 30036.0 30427.7 30574.4 31347.1 31379.0 47082.0 47428.0 47558.5 47650.0 47694.8 309245.0 310577.0 311897.0 312257.0 312764.0 33171.0 49023.5 49351.5 49668.5 49871.0 43856.6 44523.0 45133.0 45247.1 45439.1 38399.6 39160.6 39384.8 39508.8 40317.6 38604.2 38646.8 39051.2 39183.4 39190.2 43417.1 43446.6 43532.1 43938.3 44538.8 33236.7 33447.8 34162.1 34165.7 34213.3 26482.5 27095.7 27309.9 27469.0 27518.4 03:36:53 INFO - 2016-01-01 03:36:53,343 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,343 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32960.48 Median:1924.42 stddev:109307.89 (5680.0%) stddev-sans-first:109587.15 03:36:53 INFO - 2016-01-01 03:36:53,344 DEBUG : BROWSER_OUTPUT: Values: 379.7 391.4 391.6 393.4 394.4 16569.0 16832.0 18158.9 18163.7 18496.6 18213.6 18232.7 18317.1 18672.2 18705.6 5141.9 5259.4 5267.8 5269.0 5274.9 5261.8 5715.5 5849.4 5896.3 5910.8 5820.9 5822.7 5824.1 5832.7 5886.3 6082.8 6397.3 6402.8 6408.5 6435.8 5503.7 5685.9 5719.7 5723.0 5743.8 13828.0 13847.5 13886.2 16078.4 22119.4 2189.2 2197.8 2251.1 2265.0 2313.3 10616.7 10716.7 11063.0 11281.9 14602.1 1921.2 1927.6 1953.9 2007.5 2009.2 63335.7 64026.7 64907.0 65781.0 66458.7 11060.0 11123.8 11165.4 11178.9 11194.6 14748.9 14750.8 14752.1 14819.0 14849.0 7999.2 8033.8 8040.8 8059.6 8110.6 7789.7 7796.2 7809.3 7822.8 7823.9 4753.4 4825.9 4845.0 4851.7 4882.0 1912.7 2013.7 2021.7 2045.5 2071.7 1085.0 1118.3 1122.9 1124.2 1132.5 15938.4 16018.6 16691.2 16831.7 17949.9 1031.7 1035.6 1050.1 1084.0 1088.7 9449.4 9535.2 9716.0 9728.7 10364.2 651010.0 655458.0 662022.0 685590.0 693508.0 81486.3 82891.6 83640.0 85103.1 85145.0 1135.7 1138.4 1151.6 1177.3 1224.9 15636.8 16067.6 16159.6 16460.2 16578.3 33778.3 33867.2 34208.8 36911.3 38016.6 44539.3 45704.3 46826.8 46843.5 47122.5 10067.4 10568.8 10701.7 10725.2 10868.8 12447.3 16857.8 17490.7 17841.6 18297.2 15122.9 15344.0 15485.6 15596.8 16172.0 14678.3 14996.0 15054.4 15720.4 15905.6 15221.3 15276.0 15356.2 15500.0 15882.3 9841.9 10155.5 10255.2 10438.4 10644.6 10339.3 10622.6 10624.2 10860.8 15241.2 03:36:53 INFO - 2016-01-01 03:36:53,344 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,344 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5821.73 Median:5609.65 stddev:3021.23 (53.9%) stddev-sans-first:3012.79 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: Values: 1568.0 1602.0 1631.9 1804.7 1876.2 8001.7 8263.3 8446.0 8514.0 8554.4 8448.4 8475.0 8515.2 8524.9 8552.5 2405.2 2424.9 2440.2 2441.0 2446.5 2455.9 2476.6 2478.9 2486.2 2512.2 2372.2 2379.3 2383.2 2402.4 2418.3 2336.3 2383.9 2439.3 2441.7 2444.1 2444.1 2460.9 2472.2 2476.6 2483.6 8231.8 8312.1 8331.5 8348.8 8379.7 4990.4 5072.0 5079.0 5086.7 5163.5 3194.4 3194.5 3194.8 3225.8 3234.9 1037.6 1048.6 1056.3 1082.4 1089.8 11394.3 11427.4 11447.0 11456.8 11482.7 4343.1 4360.9 4365.6 4472.7 4486.9 9307.7 9321.0 9334.4 9352.5 9357.9 4988.6 5044.4 5046.7 5050.7 5064.3 4556.0 4576.7 4601.7 4622.8 4631.3 3632.0 3711.9 3725.6 3729.1 3750.6 1114.8 1122.4 1129.0 1134.3 1210.0 983.4 989.2 1013.2 1184.7 1478.6 7839.5 7953.8 7957.6 8019.3 8039.6 1158.2 1172.8 1173.1 1190.4 1193.8 6055.8 6105.2 6106.8 6167.6 6195.9 9947.1 10045.6 10101.4 10106.6 10170.1 9144.8 10004.9 10034.6 10064.4 10151.1 7739.7 7804.5 7824.8 7845.3 7915.0 7654.0 7704.4 7785.6 7821.4 7827.5 8579.4 8598.7 8616.8 8766.5 8807.0 8847.7 8995.5 9013.7 9171.0 9252.5 7477.3 7478.0 7555.0 7556.5 7559.4 7967.7 8083.1 8113.0 8134.2 8134.8 6598.2 7529.1 7620.6 7675.3 7704.1 7223.5 7271.3 7338.1 7364.2 7485.4 7490.7 7578.4 7581.2 7591.8 7594.0 6752.2 6880.9 6899.4 6906.1 6909.7 6986.9 7013.4 7030.8 7055.1 7059.6 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5767.34 Median:6512.56 stddev:1703.71 (26.2%) stddev-sans-first:1659.55 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: Values: 365.7 371.1 372.7 373.3 375.0 6347.3 6427.1 6471.9 6496.2 6497.8 6217.3 6394.6 6397.2 6397.9 6420.5 4947.7 4952.0 4958.0 4959.2 4966.8 4960.7 4965.0 4969.0 4979.8 4986.0 4824.2 4917.6 4964.4 4985.0 4987.0 4892.1 4897.1 4912.8 4972.7 4975.3 4387.6 4400.1 4408.0 4415.3 4418.1 5989.1 6123.8 6143.4 6150.8 6156.3 5823.9 5833.7 5840.2 5846.2 5857.6 6903.2 6904.5 6910.9 6918.7 6935.5 4893.8 4898.6 4900.9 4904.0 4912.5 6882.6 7097.1 7129.8 7142.6 7157.4 5017.9 5020.7 5022.3 5031.3 5041.9 5089.8 5091.8 5101.9 5108.4 5113.0 5722.0 5810.2 5812.4 5814.3 5818.3 6913.7 6917.7 6920.3 6923.4 6936.1 1759.6 1782.9 1794.2 1795.0 1796.2 1210.1 1222.4 1242.9 1250.8 1252.5 6526.1 6621.2 6631.0 6648.1 6650.6 7023.5 7062.2 7074.2 7081.3 7086.9 6499.0 6597.0 6609.4 6616.8 6636.9 3792.9 3843.6 3846.2 3846.8 3854.9 7180.1 7182.1 7207.0 7216.0 7228.1 7097.9 7122.2 7197.7 7205.0 7236.0 7179.8 7182.0 7184.4 7190.2 7198.6 7013.3 7063.1 7069.8 7075.6 7079.0 6847.4 6908.2 6962.3 6967.3 6971.5 7138.4 7204.6 7204.7 7205.6 7218.6 4991.8 5025.7 5034.5 5050.3 5054.2 6938.9 6995.0 7058.2 7135.6 7207.6 6938.3 6966.1 6969.0 6992.2 6995.7 6926.3 6930.7 6933.0 6933.5 6946.4 6698.9 6859.5 6864.6 6873.2 6877.6 6992.3 6998.9 7012.1 7024.9 7044.7 6711.9 6805.7 6824.5 6852.7 6853.8 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14419.40 Median:4516.91 stddev:15973.49 (353.6%) stddev-sans-first:15986.10 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: Values: 914.2 927.5 943.5 943.7 947.1 14160.6 14427.6 14499.4 14503.4 14556.1 13804.2 13856.5 13899.8 13901.5 13938.7 729.4 740.9 875.5 899.8 912.1 893.2 893.8 894.9 896.3 898.2 935.1 937.7 941.1 944.8 946.2 939.8 941.0 941.5 942.5 943.8 685.1 687.5 690.2 692.3 694.9 14000.5 14005.0 14082.6 14092.2 14102.7 11898.0 12856.7 12942.8 13281.8 13634.9 10750.5 10839.0 11000.9 11013.4 11022.9 3714.6 3732.3 3752.1 3793.8 3830.7 47289.0 47387.8 47442.8 47697.8 48807.3 10287.6 10795.6 10964.5 11005.9 11027.7 19062.5 19094.9 19130.2 19144.8 19208.7 7982.0 8048.5 8136.3 8170.4 8276.6 4399.6 4493.5 4499.5 4534.3 4618.1 3303.0 3332.9 3361.3 3365.1 3379.7 602.5 611.0 616.4 616.5 623.6 728.7 742.2 746.1 753.4 753.9 8884.6 9175.5 9331.5 9384.0 9489.5 586.2 650.6 683.3 694.1 699.0 4193.6 4452.0 4587.8 4623.4 4629.6 52867.0 52868.0 53118.5 53157.2 60637.0 47821.8 48426.8 48839.0 48877.8 49631.5 48950.8 49170.0 53180.7 53345.7 53539.5 9387.2 9570.6 9595.9 9746.3 9894.8 34743.7 35047.5 35107.8 35809.6 36040.3 44008.8 46472.0 49516.8 49606.3 49744.8 11012.8 11886.0 12110.2 12201.4 12219.5 13448.9 13505.1 13589.0 13974.0 14334.8 12556.4 12959.7 13210.8 13229.7 13388.7 12848.4 12992.2 13464.3 13637.5 13767.7 11872.5 12441.3 12635.5 12835.3 13482.6 10638.9 10945.0 11067.0 11142.6 11445.7 10757.8 10800.2 10976.7 11081.5 11133.0 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:36:53 INFO - 2016-01-01 03:36:53,346 DEBUG : BROWSER_OUTPUT: 03:36:53 INFO - 2016-01-01 03:36:53,937 INFO : Browser exited with error code: 0 03:36:53 INFO - 2016-01-01 03:36:53,956 INFO : Completed test dromaeo_css (00:18:28) 03:36:53 INFO - 2016-01-01 03:36:53,956 INFO : Starting test kraken 03:36:53 INFO - 2016-01-01 03:36:53,956 DEBUG : operating with platform_type : linux_ 03:36:53 INFO - 2016-01-01 03:36:53,956 INFO : Initialising browser for kraken test... 03:36:53 INFO - 2016-01-01 03:36:53,963 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjs1V6B/profile http://localhost:33412/getInfo.html 03:36:58 INFO - 2016-01-01 03:36:58,181 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:36:58 INFO - 2016-01-01 03:36:58,181 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:36:58 INFO - 2016-01-01 03:36:58,181 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:36:58 INFO - 2016-01-01 03:36:58,181 DEBUG : BROWSER_OUTPUT: __metrics 03:36:59 INFO - 2016-01-01 03:36:59,177 INFO : Browser initialized. 03:36:59 INFO - 2016-01-01 03:36:59,178 INFO : Running cycle 1/1 for kraken test... 03:36:59 INFO - 2016-01-01 03:36:59,178 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjs1V6B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:37:10 INFO - 2016-01-01 03:37:10,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 137326592 03:37:10 INFO - 2016-01-01 03:37:10,966 DEBUG : BROWSER_OUTPUT: 03:37:13 INFO - 2016-01-01 03:37:13,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33412/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:13 INFO - 2016-01-01 03:37:13,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 03:37:13 INFO - 2016-01-01 03:37:13,995 DEBUG : BROWSER_OUTPUT: 03:37:16 INFO - 2016-01-01 03:37:16,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33412/tests/kraken/driver.html?testName=audio-dft) 03:37:17 INFO - 2016-01-01 03:37:17,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 138878976 03:37:17 INFO - 2016-01-01 03:37:17,219 DEBUG : BROWSER_OUTPUT: 03:37:20 INFO - 2016-01-01 03:37:20,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33412/tests/kraken/driver.html?testName=audio-fft) 03:37:20 INFO - 2016-01-01 03:37:20,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 139415552 03:37:20 INFO - 2016-01-01 03:37:20,641 DEBUG : BROWSER_OUTPUT: 03:37:22 INFO - 2016-01-01 03:37:22,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33412/tests/kraken/driver.html?testName=audio-oscillator) 03:37:23 INFO - 2016-01-01 03:37:23,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 139657216 03:37:23 INFO - 2016-01-01 03:37:23,227 DEBUG : BROWSER_OUTPUT: 03:37:25 INFO - 2016-01-01 03:37:25,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:26 INFO - 2016-01-01 03:37:26,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 139694080 03:37:26 INFO - 2016-01-01 03:37:26,012 DEBUG : BROWSER_OUTPUT: 03:37:28 INFO - 2016-01-01 03:37:28,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33412/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:29 INFO - 2016-01-01 03:37:29,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 139149312 03:37:29 INFO - 2016-01-01 03:37:29,513 DEBUG : BROWSER_OUTPUT: 03:37:32 INFO - 2016-01-01 03:37:32,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33412/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:33 INFO - 2016-01-01 03:37:33,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 03:37:33 INFO - 2016-01-01 03:37:33,448 DEBUG : BROWSER_OUTPUT: 03:37:36 INFO - 2016-01-01 03:37:36,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33412/tests/kraken/driver.html?testName=json-parse-financial) 03:37:36 INFO - 2016-01-01 03:37:36,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 03:37:36 INFO - 2016-01-01 03:37:36,833 DEBUG : BROWSER_OUTPUT: 03:37:38 INFO - 2016-01-01 03:37:38,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:38 INFO - 2016-01-01 03:37:38,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 139710464 03:37:38 INFO - 2016-01-01 03:37:38,971 DEBUG : BROWSER_OUTPUT: 03:37:40 INFO - 2016-01-01 03:37:40,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:41 INFO - 2016-01-01 03:37:41,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 139026432 03:37:41 INFO - 2016-01-01 03:37:41,324 DEBUG : BROWSER_OUTPUT: 03:37:43 INFO - 2016-01-01 03:37:43,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:43 INFO - 2016-01-01 03:37:43,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 139329536 03:37:43 INFO - 2016-01-01 03:37:43,950 DEBUG : BROWSER_OUTPUT: 03:37:46 INFO - 2016-01-01 03:37:46,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:46 INFO - 2016-01-01 03:37:46,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 139915264 03:37:46 INFO - 2016-01-01 03:37:46,939 DEBUG : BROWSER_OUTPUT: 03:37:49 INFO - 2016-01-01 03:37:49,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:50 INFO - 2016-01-01 03:37:50,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 03:37:50 INFO - 2016-01-01 03:37:50,060 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33412/tests/kraken/driver.html?testName=ai-astar) 03:37:51 INFO - 2016-01-01 03:37:51,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 03:37:51 INFO - 2016-01-01 03:37:51,970 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;110;109;110;120;108;109;109;108 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;128;146;161;125;151;149;134;172;130 03:37:51 INFO - 2016-01-01 03:37:51,974 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;160;161;161;163;159;163;161 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;72;150;71;71;72;73;157;72 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;132;93;93;93;146;93;93;135 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;109;109;110;110;110 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;147;147;147;146;146;146 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;95;95;96;96;96;96;96;96;96 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;64;61;62;61;61;61;61;59 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;63;63;63;64;64;62;63;63;63 03:37:51 INFO - 2016-01-01 03:37:51,975 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;83;89;82;82;80;82;83;82;82 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;110;113;116;124;121;113;121;115;122;116 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;147;149;145;157;150;151;146;143;141 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;67;69;65;69;65;65;68;68 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,717 03:37:51 INFO - 2016-01-01 03:37:51,976 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:37:51 INFO - 2016-01-01 03:37:51,977 DEBUG : BROWSER_OUTPUT: __startTimestamp1451648271972__endTimestamp 03:37:51 INFO - 2016-01-01 03:37:51,977 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,980 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:37:51 INFO - 2016-01-01 03:37:51,980 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.90 Median:109.50 stddev:3.75 (3.4%) stddev-sans-first:3.98 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 110.0 109.0 110.0 120.0 108.0 109.0 109.0 108.0 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:15.15 (10.3%) stddev-sans-first:16.06 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: Values: 145.0 128.0 146.0 161.0 125.0 151.0 149.0 134.0 172.0 130.0 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 160.0 161.0 161.0 163.0 159.0 163.0 161.0 03:37:51 INFO - 2016-01-01 03:37:51,981 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.80 Median:72.00 stddev:34.20 (47.5%) stddev-sans-first:36.05 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 72.0 150.0 71.0 71.0 72.0 73.0 157.0 72.0 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:21.85 (23.5%) stddev-sans-first:22.64 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 132.0 93.0 93.0 93.0 146.0 93.0 93.0 135.0 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,982 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.45 (2.4%) stddev-sans-first:1.36 03:37:51 INFO - 2016-01-01 03:37:51,983 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 64.0 61.0 62.0 61.0 61.0 61.0 61.0 59.0 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:0.60 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: Values: 66.0 63.0 63.0 63.0 64.0 64.0 62.0 63.0 63.0 63.0 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.63 (3.2%) stddev-sans-first:2.49 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: Values: 79.0 83.0 89.0 82.0 82.0 80.0 82.0 83.0 82.0 82.0 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:118.50 stddev:4.63 (3.9%) stddev-sans-first:4.14 03:37:51 INFO - 2016-01-01 03:37:51,984 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 116.0 124.0 121.0 113.0 121.0 115.0 122.0 116.0 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:148.00 stddev:5.44 (3.7%) stddev-sans-first:4.77 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: Values: 138.0 147.0 149.0 145.0 157.0 150.0 151.0 146.0 143.0 141.0 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.69 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 67.0 69.0 65.0 69.0 65.0 65.0 68.0 68.0 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:37:51 INFO - 2016-01-01 03:37:51,985 DEBUG : BROWSER_OUTPUT: 03:37:52 INFO - 2016-01-01 03:37:52,849 INFO : Browser exited with error code: 0 03:37:52 INFO - 2016-01-01 03:37:52,897 INFO : Completed test kraken (00:00:58) 03:37:52 INFO - 2016-01-01 03:37:52,898 INFO : Starting test v8_7 03:37:52 INFO - 2016-01-01 03:37:52,898 DEBUG : operating with platform_type : linux_ 03:37:52 INFO - 2016-01-01 03:37:52,898 INFO : Initialising browser for v8_7 test... 03:37:52 INFO - 2016-01-01 03:37:52,904 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Eok6f/profile http://localhost:33412/getInfo.html 03:37:57 INFO - 2016-01-01 03:37:57,149 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:37:57 INFO - 2016-01-01 03:37:57,149 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:37:57 INFO - 2016-01-01 03:37:57,149 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:37:57 INFO - 2016-01-01 03:37:57,149 DEBUG : BROWSER_OUTPUT: __metrics 03:37:58 INFO - 2016-01-01 03:37:58,077 INFO : Browser initialized. 03:37:58 INFO - 2016-01-01 03:37:58,078 INFO : Running cycle 1/1 for v8_7 test... 03:37:58 INFO - 2016-01-01 03:37:58,078 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0Eok6f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:38:09 INFO - 2016-01-01 03:38:09,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 137265152 03:38:09 INFO - 2016-01-01 03:38:09,834 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33412/tests/v8_7/run.html (next: http://localhost:33412/tests/v8_7/run.html) 03:38:31 INFO - 2016-01-01 03:38:31,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 135159808 03:38:31 INFO - 2016-01-01 03:38:31,393 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,393 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:38:31 INFO - 2016-01-01 03:38:31,393 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:38:31 INFO - 2016-01-01 03:38:31,394 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:38:31 INFO - 2016-01-01 03:38:31,394 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:38:31 INFO - 2016-01-01 03:38:31,394 DEBUG : BROWSER_OUTPUT: |0;Richards;172.95053614666205 03:38:31 INFO - 2016-01-01 03:38:31,394 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.72224074691565 03:38:31 INFO - 2016-01-01 03:38:31,395 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 03:38:31 INFO - 2016-01-01 03:38:31,395 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 03:38:31 INFO - 2016-01-01 03:38:31,395 DEBUG : BROWSER_OUTPUT: |4;RayTrace;910.7468123861566 03:38:31 INFO - 2016-01-01 03:38:31,395 DEBUG : BROWSER_OUTPUT: |5;Earley;547.0459518599563 03:38:31 INFO - 2016-01-01 03:38:31,396 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.010989010989 03:38:31 INFO - 2016-01-01 03:38:31,396 DEBUG : BROWSER_OUTPUT: |7;RegExp;23857.14285714286 03:38:31 INFO - 2016-01-01 03:38:31,396 DEBUG : BROWSER_OUTPUT: |8;Splay;525.2100840336135 03:38:31 INFO - 2016-01-01 03:38:31,396 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 03:38:31 INFO - 2016-01-01 03:38:31,397 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:38:31 INFO - 2016-01-01 03:38:31,397 DEBUG : BROWSER_OUTPUT: __startTimestamp1451648311391__endTimestamp 03:38:31 INFO - 2016-01-01 03:38:31,397 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,397 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:38:31 INFO - 2016-01-01 03:38:31,398 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:38:31 INFO - 2016-01-01 03:38:31,398 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,398 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.95 Median:172.95 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,399 DEBUG : BROWSER_OUTPUT: Values: 173.0 03:38:31 INFO - 2016-01-01 03:38:31,399 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,399 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,399 DEBUG : BROWSER_OUTPUT: Values: 166.7 03:38:31 INFO - 2016-01-01 03:38:31,400 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,400 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,400 DEBUG : BROWSER_OUTPUT: Values: 277.9 03:38:31 INFO - 2016-01-01 03:38:31,400 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,400 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: Values: 5181.3 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:910.75 Median:910.75 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: Values: 910.7 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,401 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: Values: 547.0 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.01 Median:10989.01 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: Values: 10989.0 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23857.14 Median:23857.14 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: Values: 23857.1 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,402 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:525.21 Median:525.21 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: Values: 525.2 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: Values: 4854.4 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:38:31 INFO - 2016-01-01 03:38:31,403 DEBUG : BROWSER_OUTPUT: 03:38:32 INFO - 2016-01-01 03:38:32,213 INFO : Browser exited with error code: 0 03:38:32 INFO - 2016-01-01 03:38:32,232 INFO : Completed test v8_7 (00:00:39) 03:38:32 INFO - 2016-01-01 03:38:32,482 INFO : Completed test suite (00:20:06) 03:38:32 INFO - 2016-01-01 03:38:32,482 DEBUG : Working with test: dromaeo_css 03:38:32 INFO - 2016-01-01 03:38:32,482 DEBUG : Generating results file: dromaeo_css 03:38:32 INFO - 2016-01-01 03:38:32,483 DEBUG : Working with test: kraken 03:38:32 INFO - 2016-01-01 03:38:32,483 DEBUG : Generating results file: kraken 03:38:32 INFO - 2016-01-01 03:38:32,484 INFO : javascript benchmark 03:38:32 INFO - 2016-01-01 03:38:32,484 DEBUG : Working with test: v8_7 03:38:32 INFO - 2016-01-01 03:38:32,484 DEBUG : Generating results file: v8_7 03:38:32 INFO - 2016-01-01 03:38:32,484 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:32 INFO - 2016-01-01 03:38:32,531 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:38:32 INFO - 2016-01-01 03:38:32,531 DEBUG : process_Request line: dromaeo_css 7455.82 graph.html#tests=[[72,52,43]] 03:38:32 INFO - 2016-01-01 03:38:32,531 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:32 INFO - 2016-01-01 03:38:32,561 DEBUG : process_Request line: kraken 1499.90 graph.html#tests=[[232,52,43]] 03:38:32 INFO - 2016-01-01 03:38:32,561 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:38:32 INFO - 2016-01-01 03:38:32,590 DEBUG : process_Request line: v8_7 23191.71 graph.html#tests=[[230,52,43]] 03:38:32 INFO - 2016-01-01 03:38:32,591 INFO : javascript benchmark 03:38:32 INFO - 2016-01-01 03:38:32,595 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3369.747268954828, 3405.3359594878993, 3409.5908490981087, 3441.5698037745283, 3447.0520606833124, 5525.088360420531, 5547.500724934755, 5563.026470367689, 5573.136163894597, 5575.330960284767, 5525.4474552544725, 5618.185363122345, 5643.915341269874, 5647.915281270774, 5694.800681976131, 5073.822416215442, 5152.072626927152, 5176.12005958986, 5193.272941788153, 5229.947700522984, 5065.7467126643705, 5126.641135120543, 5138.203578445328, 5212.4266330703595, 5252.6323157379, 5133.204353325222, 5201.167813149897, 5201.531862132426, 5203.089459344618, 5225.163973764198, 5158.458361871987, 5259.474052594748, 5280.419153893069, 5286.762095705702, 5292.417834038291, 4935.0376676548085, 4953.975230123862, 5003.5997120230295, 5155.871103222412, 5170.353705786777, 5389.8113566025, 5460.7542660579975, 5468.64453810505, 5478.972605136989, 5479.589030822704, 6048.334683184846, 6061.818145455643, 6084.6045007074845, 6102.572819902609, 6106.786262480836, 5894.734736936848, 6021.458068773832, 6068.939310606882, 6142.140100385949, 6177.567570270083, 5649.406812284733, 5702.059160238556, 5706.71466426677, 5726.169705392736, 5730.36965933747, 6192.690365481708, 6199.814005579839, 6205.317415084337, 6214.875702486015, 6219.346968568326, 5765.596408251466, 5855.268091488564, 5882.617629854046, 5956.821295361146, 5988.6706231157705, 6028.849278767978, 6094.939050609526, 6130.1724267224245, 6170.352113028157, 6172.135900973867, 5901.114832775118, 6073.726682299307, 6142.600730952474, 6147.44672979434, 6160.537959653044, 5946.702664866826, 6022.0, 6090.543209259324, 6118.908216376758, 6127.509799216052, 4568.908621827545, 4611.123886461562, 4648.1168577970075, 4662.300654901792, 4665.206914824488, 4053.0475338296064, 4129.504459464823, 4206.3690446432665, 4211.957880421157, 4252.851150209728, 5819.330776960619, 5878.0, 5906.173135760997, 5920.082387229986, 5928.081147422156, 6160.168377269011, 6174.413430724074, 6178.196834411498, 6180.443760061616, 6187.102870083902, 5625.268715067015, 5626.549876009991, 5727.31272247333, 5893.233879595625, 5902.675352855548, 5092.2361645753435, 5112.71880046601, 5137.17805151174, 5151.407588127338, 5160.225966105114, 6178.814635560941, 6225.128482012522, 6249.500039996789, 6256.906146407808, 6260.780872669526, 5899.174115623902, 6057.939420605738, 6087.634741915499, 6135.478484328793, 6153.384661533811, 6217.751289948352, 6294.968525157345, 6307.36926307384, 6334.619922804646, 6336.936630633634, 6081.118237855575, 6094.786682466092, 6103.23709536308, 6119.632822030692, 6123.877522449615, 5921.348651648402, 6019.879602408015, 6113.816585502442, 6179.320274769681, 6213.813585592439, 5987.43119403656, 5992.910106348321, 5993.910091348546, 5998.970005150121, 6015.428534289235, 5921.526277897672, 5956.315023772322, 5970.9701451492465, 5980.401959803985, 5980.760769569169, 5660.801871934463, 5775.595708300547, 5837.29952405714, 5874.911876321944, 5935.940640593712, 5930.881382372415, 6037.18498002764, 6080.543959202989, 6109.908351374644, 6114.205153330038, 5614.803481878114, 5931.169636250842, 5939.732712027882, 5942.376050514634, 5960.0], "unit": "ms", "name": "dojo.html", "value": 5604.715530815284}, {"lowerIsBetter": false, "replicates": [604.6372176693984, 609.9390060993901, 636.4717284653738, 652.5269179844611, 663.3002182697254, 31339.373212535735, 31984.36031279376, 37024.814875925615, 37746.24507509848, 37919.81040094796, 39473.60526394735, 39515.60484395155, 39749.40375894364, 39835.0, 39966.0, 9118.726438206848, 9244.029376915429, 9244.722658320261, 9248.398854074498, 9280.257579393632, 9000.639974401016, 9107.544622768868, 9117.45295282282, 9128.863067053966, 9171.0, 9030.50332231727, 9127.406718563305, 9159.22146617535, 9160.45037297761, 9162.862557061617, 9066.954665226665, 9119.908800911971, 9125.315601329927, 9163.35856490046, 9183.770405739842, 8845.646174153026, 9060.0, 9078.364514483988, 9079.092090790935, 9089.0, 41388.793056034825, 41892.3716144255, 41918.0, 41934.58065419337, 42090.1581968362, 3556.324298383299, 3621.4205727083804, 3716.832742526593, 3783.8486460541544, 4007.699422543321, 31987.6801231987, 32000.0, 32000.679993200003, 32141.839290803397, 32620.836895815606, 4168.874933751992, 4364.0, 4366.061296821199, 4368.0, 4370.169667763146, 251267.74366128235, 251543.0, 251562.0, 251913.0, 251989.0, 44267.55732442699, 44428.3335749964, 44430.55569444264, 44776.3283550747, 44857.775711121234, 41981.79009104935, 42333.788331058764, 42430.78784606057, 42454.57545424506, 42468.150636987084, 14499.420023198954, 14551.126932384092, 14586.4894728684, 14624.049436786574, 14628.926855365655, 11425.428728563538, 11551.249168804, 11556.306621602731, 11582.47878845454, 11776.94111529454, 15170.469033583771, 15259.313330900137, 15288.312025958636, 15297.847021529642, 15393.769093463607, 6081.817545473555, 6103.572749907553, 6117.449429551361, 6146.7233974471255, 6161.44546990773, 1008.4302369161401, 1102.0522350778324, 1109.0074383426788, 1121.1647322744445, 1225.650689553473, 27371.452570948866, 27377.726222737918, 27471.0, 27606.0337888177, 27622.861885690443, 1127.7406196574834, 1143.4168574027306, 1178.4049055227056, 1184.8992835608897, 1247.2391840976998, 14668.413263469554, 14669.633259168606, 14886.70226595462, 14941.327640255997, 15014.624634384008, 421145.0, 770866.0, 801876.0, 805258.0, 810668.0, 57551.424485755444, 57931.71034144887, 58548.41451585515, 58580.0, 58582.70708646515, 1381.1367895065584, 1472.4331132513846, 1490.69440764643, 1501.8122734658168, 1509.0794615284667, 30036.0, 30427.695723042485, 30574.388512230074, 31347.05958821239, 31379.0, 47082.0, 47428.0, 47558.52441475541, 47650.0, 47694.761526192146, 309245.0, 310577.0, 311897.0, 312257.0, 312764.0, 33171.0, 49023.50976490189, 49351.50648493613, 49668.503314967835, 49871.0, 43856.56143438525, 44523.0, 45133.0, 45247.09505809931, 45439.091218176116, 38399.616003839605, 39160.60839391684, 39384.80307598443, 39508.802455987534, 40317.59682403138, 38604.22791544097, 38646.806765965994, 39051.2189756209, 39183.41224881686, 39190.216195675355, 43417.131657366044, 43446.56553434425, 43532.12935741204, 43938.34092488679, 44538.777306114556, 33236.667633323355, 33447.83276083604, 34162.14594635154, 34165.65834341724, 34213.31573368568, 26482.470350593267, 27095.72904271011, 27309.86345068262, 27469.0, 27518.449631006868], "unit": "ms", "name": "ext.html", "value": 19257.53287843769}, {"lowerIsBetter": false, "replicates": [379.7171107524894, 391.4304686680879, 391.60643553229, 393.39024512006387, 394.439895348605, 16569.0, 16832.0, 18158.909205453972, 18163.72754408685, 18496.630067398644, 18213.63572728548, 18232.72650910234, 18317.084145792724, 18672.159752811123, 18705.62588748224, 5141.897162056747, 5259.368875734917, 5267.76295066721, 5268.973655131738, 5274.92087618686, 5261.76322065508, 5715.485606295432, 5849.356570777232, 5896.262967129109, 5910.822675319726, 5820.912686309709, 5822.679752613604, 5824.068149096145, 5832.650040997532, 5886.293644762634, 6082.787102451415, 6397.296297407282, 6402.839929001766, 6408.51936104794, 6435.806925792233, 5503.669779813224, 5685.943140568624, 5719.7140142992685, 5722.9984752668115, 5743.798967036176, 13828.0, 13847.515336963259, 13886.236257005861, 16078.437254696146, 22119.44701382478, 2189.179057853305, 2197.769234230415, 2251.1445650652813, 2264.9886750566143, 2313.306008197551, 10616.734581635445, 10716.678499645022, 11063.0, 11281.943590281997, 14602.050866693631, 1921.2315073970383, 1927.6144771045847, 1953.9413817585496, 2007.5081605006721, 2009.1561544151346, 63335.68332158356, 64026.67986660083, 64907.0, 65780.99999999952, 66458.66770666164, 11060.0, 11123.833142502868, 11165.385903775208, 11178.944105279421, 11194.608188713519, 14748.926255368655, 14750.778738318933, 14752.114873107648, 14819.0, 14849.0, 7999.1600881907725, 8033.839323213503, 8040.839183216303, 8059.556724380215, 8110.5539195343645, 7789.688412463552, 7796.181400952818, 7809.297163255334, 7822.765317040498, 7823.921760782433, 4753.382060332135, 4825.879353016133, 4845.0, 4851.733154676526, 4881.975590122098, 1912.722655214986, 2013.7281467001767, 2021.7472815898013, 2045.4681782736297, 2071.6892466130203, 1085.0288991352695, 1118.3290025984345, 1122.910167186623, 1124.1961997172061, 1132.4790596325784, 15938.36246550125, 16018.599535011717, 16691.165441728106, 16831.663366732595, 17949.910250448665, 1031.6698656430021, 1035.5909415780875, 1050.112654806687, 1084.0378914165228, 1088.684281558355, 9449.43303401798, 9535.2371810255, 9716.0, 9728.659496917573, 10364.170866330676, 651010.0, 655458.0, 662022.0, 685590.0, 693508.0, 81486.33311500997, 82891.5855420719, 83640.0, 85103.14896851077, 85145.0, 1135.73310272086, 1138.3966497756203, 1151.5566506894738, 1177.2995067934564, 1224.908131890112, 15636.765448518054, 16067.598310042342, 16159.596010099842, 16460.176991150154, 16578.253978571236, 33778.3244335107, 33867.15332116717, 34208.82895585506, 36911.26177476489, 38016.619833801306, 44539.331910022025, 45704.31443528416, 46826.76586617045, 46843.53156468528, 47122.52877471181, 10067.395956242648, 10568.788624227625, 10701.678949631523, 10725.195610329412, 10868.836967445337, 12447.253164810141, 16857.831421686118, 17490.650186996445, 17841.553961150556, 18297.176627051547, 15122.877122877122, 15344.0, 15485.612859678598, 15596.84403155954, 16172.0, 14678.339474723876, 14996.0, 15054.397824087351, 15720.371185152922, 15905.602359941095, 15221.31504082341, 15276.0, 15356.155411452477, 15500.0, 15882.285297161887, 9841.85237221428, 10155.543000564845, 10255.230857685852, 10438.37369757817, 10644.574217031543, 10339.276250662382, 10622.628208012682, 10624.203184761329, 10860.837087443537, 15241.237938103272], "unit": "ms", "name": "jquery.html", "value": 9403.20155515818}, {"lowerIsBetter": false, "replicates": [1567.9764803527946, 1602.0122471590487, 1631.9347226110956, 1804.6661367646986, 1876.2119909637943, 8001.679932802688, 8263.33893288537, 8445.957770211156, 8513.957430212848, 8554.40119191656, 8448.408611397204, 8475.0, 8515.19105684959, 8524.8721269181, 8552.486850788957, 2405.1581946318825, 2424.9151279705216, 2440.2069327468644, 2440.9755902441016, 2446.5106978604263, 2455.938601534967, 2476.554220240356, 2478.863662498562, 2486.17956074495, 2512.1648745162665, 2372.240882917467, 2379.2862141357523, 2383.2254517281954, 2402.3513651314133, 2418.3349578865864, 2336.3224664847176, 2383.9284821455385, 2439.329184474257, 2441.682581264442, 2444.0590372706456, 2444.083468699238, 2460.8769561521854, 2472.2336075816556, 2476.616124500705, 2483.639872218518, 8231.794205144859, 8312.085670576233, 8331.458455200393, 8348.833023339559, 8379.748607541784, 4990.351254336949, 5072.0, 5079.0, 5086.669366491166, 5163.535281824654, 3194.4250034993693, 3194.536792165123, 3194.8242846643425, 3225.7741958062943, 3234.91912702182, 1037.6160820496389, 1048.64346122318, 1056.3082870018443, 1082.44795154471, 1089.782043591285, 11394.25937314072, 11427.371494567795, 11447.0, 11456.828147577793, 11482.65552033432, 4343.109662519176, 4360.934585981213, 4365.585269399402, 4472.731636101845, 4486.910261794811, 9307.72076837696, 9320.95339523298, 9334.39326443779, 9352.532373381304, 9357.90642093584, 4988.6009119270375, 5044.369453818273, 5046.722430266297, 5050.747462626854, 5064.265681476165, 4555.9772201138785, 4576.748278844629, 4601.700889442242, 4622.791974361162, 4631.305304204329, 3631.9636803631624, 3711.888643340704, 3725.590185079639, 3729.1236559408517, 3750.5686846012513, 1114.7603265298, 1122.4499995002552, 1129.0403157316216, 1134.325076579434, 1209.9957035660382, 983.3804703037041, 989.1789814453986, 1013.1692012549638, 1184.7393573413835, 1478.6155599544195, 7839.490433121829, 7953.761387158394, 7957.6021198939825, 8019.278264956065, 8039.598020099089, 1158.1661203933154, 1172.7654469106042, 1173.0556901694217, 1190.3750530971308, 1193.7612477504533, 6055.757769689163, 6105.175801266772, 6106.755729770848, 6167.599106058092, 6195.907061394083, 9947.104760571583, 10045.648402305884, 10101.444420556792, 10106.595736170471, 10170.135538479164, 9144.771380715401, 10004.899951000543, 10034.598616055277, 10064.396136231702, 10151.1371533419, 7739.651715672809, 7804.453688241769, 7824.843503129906, 7845.333146682482, 7915.0, 7653.961730191313, 7704.422168337509, 7785.571793551409, 7821.374290056896, 7827.491213071132, 8579.442336248374, 8598.65605375803, 8616.827663446822, 8766.474011559327, 8807.031226565201, 8847.690330838648, 8995.505247211466, 9013.684521041732, 9171.0, 9252.537373131181, 7477.252274772479, 7477.962610187132, 7555.0, 7556.508826926232, 7559.357454616419, 7967.700655708608, 8083.110857805519, 8112.959435202786, 8134.227248411392, 8134.796630084295, 6598.175228096488, 7529.134149572869, 7620.618969051415, 7675.3475954542255, 7704.114026886979, 7223.530470519399, 7271.3455788979245, 7338.082739657543, 7364.153122390993, 7485.401167906663, 7490.70037198506, 7578.355839753683, 7581.166071732216, 7591.810204744926, 7594.0, 6752.189737231563, 6880.931190688029, 6899.379055884994, 6906.136732908387, 6909.689063992032, 6986.930130698628, 7013.368796808311, 7030.824229394306, 7055.118110236221, 7059.611721355374], "unit": "ms", "name": "mootools.html", "value": 4765.179982075086}, {"lowerIsBetter": false, "replicates": [365.7129153614412, 371.0871256708497, 372.74466990111756, 373.29819938515595, 375.04176828203947, 6347.333529979355, 6427.068075129109, 6471.9352806471925, 6496.187976502937, 6497.805065848021, 6217.253929528463, 6394.6482943438095, 6397.1683681121385, 6397.904031439532, 6420.518461115424, 4947.727874966876, 4952.034353301099, 4958.033183529214, 4959.206526955688, 4966.801327946878, 4960.702357858522, 4965.0069986002945, 4969.006198760244, 4979.825706100287, 4985.950140498603, 4824.204006338968, 4917.606591472673, 4964.379452568429, 4984.978079493713, 4987.0, 4892.14387482191, 4897.142999975008, 4912.754362281889, 4972.701637901738, 4975.278584605248, 4387.583179597933, 4400.11997600478, 4408.0, 4415.293553031532, 4418.072204836988, 5989.13157592151, 6123.785667501616, 6143.354947730513, 6150.784722534735, 6156.322804491547, 5823.854403639901, 5833.679147646878, 5840.182374467578, 5846.152307915371, 5857.648541087548, 6903.206131294915, 6904.4821638377325, 6910.896336554955, 6918.688659010357, 6935.549189302729, 4893.804247830082, 4898.5591296783105, 4900.926486102711, 4903.975480122613, 4912.459629440758, 6882.621455819928, 7097.112860892388, 7129.7861064168155, 7142.642867856586, 7157.427405807575, 5017.874553136201, 5020.698758074527, 5022.271770593244, 5031.295618613397, 5041.949580504222, 5089.770960306795, 5091.821786237464, 5101.923471147936, 5108.386993560796, 5113.0, 5721.971390143022, 5810.157527158538, 5812.418758124154, 5814.30228372598, 5818.330891947396, 6913.654317284116, 6917.688704008332, 6920.273371296042, 6923.411510021604, 6936.09830722013, 1759.6216813385183, 1782.8930264184191, 1794.2105473591578, 1795.0396537852187, 1796.1737600703561, 1210.074293165729, 1222.443788076423, 1242.8508578970582, 1250.8061250506187, 1252.5365614722612, 6526.118973938457, 6621.172353455818, 6630.9668451657435, 6648.135742353463, 6650.600963942179, 7023.508354415244, 7062.223155452896, 7074.151101867808, 7081.327273908971, 7086.893696594555, 6499.0, 6596.96701516499, 6609.438197753148, 6616.768413105518, 6636.900446493307, 3792.886213413602, 3843.557990831034, 3846.1730727893078, 3846.8461261549783, 3854.8628154694434, 7180.102487189101, 7182.138143422718, 7206.9549915262, 7215.96392018047, 7228.060352154292, 7097.858042839218, 7122.180949190806, 7197.748078817216, 7204.9639751800905, 7235.96382018097, 7179.784606461814, 7182.0, 7184.425245980414, 7190.173130090002, 7198.568085914757, 7013.263607321362, 7063.081799366049, 7069.752558660422, 7075.575465471882, 7078.964605176941, 6847.417969472452, 6908.240093589801, 6962.303769622998, 6967.338102880219, 6971.5468494547695, 7138.39323657495, 7204.603746793977, 7204.747833825791, 7205.639718014183, 7218.602976836324, 4991.775370108281, 5025.698458092526, 5034.546890779701, 5050.318207042149, 5054.241863720471, 6938.895916561357, 6994.985727069445, 7058.164877132085, 7135.643217838983, 7207.639618019183, 6938.306169383223, 6966.059581956371, 6968.965155174192, 6992.16094068715, 6995.685194166173, 6926.272741362084, 6930.688119034757, 6933.0, 6933.5493192942295, 6946.409555187865, 6698.933010669831, 6859.485538584726, 6864.622445765531, 6873.243943166148, 6877.58734475933, 6992.265812089658, 6998.930010700032, 7012.053372794811, 7024.929750702428, 7044.682989265598, 6711.865762684816, 6805.693743781443, 6824.488163387865, 6852.657367131524, 6853.828654283683], "unit": "ms", "name": "prototype.html", "value": 5219.106946691975}, {"lowerIsBetter": false, "replicates": [914.2000749344323, 927.5315965437455, 943.5470973932516, 943.6649989253815, 947.0813311088242, 14160.57518274451, 14427.567172984802, 14499.420023199073, 14503.419863205472, 14556.05385649932, 13804.171749695026, 13856.515021974234, 13899.79150312746, 13901.513447029356, 13938.721225575482, 729.3873146556891, 740.9073865766779, 875.483464755794, 899.7525680437899, 912.1471424218344, 893.2407453664398, 893.8346405914926, 894.8568229083348, 896.3456676626067, 898.1602201941173, 935.0555938502127, 937.690562114504, 941.1388579449796, 944.773254418938, 946.2146418472686, 939.7650587353128, 940.9811803763921, 941.5010044676333, 942.5475771629656, 943.7640589852537, 685.0888318536385, 687.5084314715003, 690.2234985641154, 692.3076923076923, 694.9478789090839, 14000.509982150576, 14005.0, 14082.577522674335, 14092.154470731788, 14102.71794564103, 11898.0, 12856.678583035406, 12942.805857912139, 13281.785065560249, 13634.93182534091, 10750.462476876124, 10839.0, 11000.889991100066, 11013.449327533672, 11022.944885275523, 3714.628537146291, 3732.2908647356917, 3752.0994961209385, 3793.7723736575617, 3830.731848770587, 47289.0, 47387.76306118482, 47442.76278618619, 47697.76151119222, 48807.26789098166, 10287.639932602324, 10795.6221532246, 10964.451777411257, 11005.944970275097, 11027.676678798434, 19062.523436914187, 19094.904525477283, 19130.234790608498, 19144.808551914302, 19208.71186932197, 7982.042154941328, 8048.476849004796, 8136.349092072738, 8170.387220958333, 8276.627551760184, 4399.626031787334, 4493.505714371417, 4499.52754960731, 4534.297183936429, 4618.0994706032, 3303.042117785815, 3332.9333413331597, 3361.3445378151514, 3365.1418888183357, 3379.729621630264, 602.4999250621973, 611.0437165835542, 616.4236438929615, 616.4513582911212, 623.6320570863122, 728.6538894025401, 742.2280827938883, 746.0823187479431, 753.3596443023496, 753.8982237397881, 8884.555772211494, 9175.541222938826, 9331.486768227813, 9383.953080234554, 9489.525523723787, 586.1617886422457, 650.5771248688391, 683.2586643491867, 694.1496666583395, 698.9615571143535, 4193.619230154949, 4451.955480445219, 4587.770611469413, 4623.375844261049, 4629.560191781776, 52867.0, 52868.0, 53118.468815312124, 53157.2026419604, 60637.0, 47821.76089119602, 48426.75786621044, 48839.0, 48877.77805554819, 49631.50368496341, 48950.75524622425, 49170.0, 53180.73409632927, 53345.733271333396, 53539.464605354224, 9387.202087822612, 9570.617175313188, 9595.90404095978, 9746.31775775689, 9894.802103957736, 34743.65256347505, 35047.47428788621, 35107.824460877535, 35809.64190358063, 36040.27919441649, 44008.779956100014, 46472.0, 49516.75241623769, 49606.25590616216, 49744.75127624339, 11012.779744405227, 11886.0, 12110.152289339661, 12201.389930503618, 12219.511219551474, 13448.932755336553, 13505.12216705911, 13589.0, 13974.021818473017, 14334.784978225543, 12556.37218139071, 12959.740805184032, 13210.801837972245, 13229.735405291647, 13388.732225355634, 12848.35758212067, 12992.155509891827, 13464.326783660974, 13637.454501820213, 13767.655808604864, 11872.465739041936, 12441.253524788543, 12635.494580216688, 12835.294058826854, 13482.595522134352, 10638.89361106379, 10945.0, 11067.0, 11142.610008649659, 11445.656630301104, 10757.838632420364, 10800.24398292112, 10976.670699879016, 11081.50133244022, 11133.0], "unit": "ms", "name": "yui.html", "value": 6805.043503812094}], "name": "dromaeo_css", "value": 7455.816520286673}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 109.0, 110.0, 120.0, 108.0, 109.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [145.0, 128.0, 146.0, 161.0, 125.0, 151.0, 149.0, 134.0, 172.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 163.0, 159.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 72.0, 150.0, 71.0, 71.0, 72.0, 73.0, 157.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 132.0, 93.0, 93.0, 93.0, 146.0, 93.0, 93.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 111.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.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 64.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 63.0, 63.0, 64.0, 64.0, 62.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [79.0, 83.0, 89.0, 82.0, 82.0, 80.0, 82.0, 83.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 116.0, 124.0, 121.0, 113.0, 121.0, 115.0, 122.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [138.0, 147.0, 149.0, 145.0, 157.0, 150.0, 151.0, 146.0, 143.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 67.0, 69.0, 65.0, 69.0, 65.0, 65.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1499.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.95053614666205], "unit": "score", "name": "Richards", "value": 204.11616399999997}, {"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "DeltaBlue", "value": 396.575764}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [910.7468123861566], "unit": "score", "name": "RayTrace", "value": 812.5079219999998}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [10989.010989010989], "unit": "score", "name": "Boyer", "value": 60.64813299999995}, {"lowerIsBetter": false, "replicates": [23857.14285714286], "unit": "score", "name": "RegExp", "value": 38.185}, {"lowerIsBetter": false, "replicates": [525.2100840336135], "unit": "score", "name": "Splay", "value": 155.15886400000005}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 23191.713208464713}]} 03:38:32 INFO - RETURN: dromaeo_css: 7455.82 03:38:32 INFO - RETURN: kraken: 1499.90 03:38:32 INFO - RETURN: v8_7: 23191.71 03:38:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23191.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1499.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7455.82"}}} 03:38:32 INFO - Return code: 0 03:38:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:38:32 INFO - # TBPL SUCCESS # 03:38:32 INFO - Running post-action listener: _resource_record_post_action 03:38:32 INFO - Running post-run listener: _resource_record_post_run 03:38:33 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 24576; Write bytes: 509149184; Read time: 32; Write time: 644472 03:38:33 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243109888; Read time: 0; Write time: 410044 03:38:33 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 24576; Write bytes: 266039296; Read time: 32; Write time: 234428 03:38:33 INFO - Running post-run listener: _upload_blobber_files 03:38:33 INFO - Blob upload gear active. 03:38:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:38:33 INFO - Copying logs to upload dir... 03:38:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.826729 ========= master_lag: 0.82 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-01 03:38:34.459200) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-01 03:38:34.463498) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009998 build_url: 'https://queue.taskcluster.net/v1/task/iUT4YsGXSICvRuhnJAGxCg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-01 03:38:34.494610) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:38:34.495064) ========= 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=a9e534cca236dfa67d42a089000001c1-1451645785.925878-128260741 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 03:38:34.548305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 03:38:34.548682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 03:38:34.549051) ========= ========= Total master_lag: 1.04 =========