builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1453397334.03 results: success (0) buildid: 20160121070721 builduid: 4acd06258fd44107ba4fa9f0cb53b611 revision: c018fbb65ecb505bc9e52fa617940ba8da5501b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.027893) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.028448) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.028804) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004350 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.046122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.046410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.057805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.058160) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.110021) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.110310) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.110670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.110945) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 09:28:54-- 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% 39.9M=0s 2016-01-21 09:28:54 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.219879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.220187) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018475 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.270433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.270785) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c018fbb65ecb505bc9e52fa617940ba8da5501b3 --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 c018fbb65ecb505bc9e52fa617940ba8da5501b3 --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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 09:28:54,808 truncating revision to first 12 chars 2016-01-21 09:28:54,808 Setting DEBUG logging. 2016-01-21 09:28:54,808 attempt 1/10 2016-01-21 09:28:54,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c018fbb65ecb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 09:28:55,053 unpacking tar archive at: mozilla-aurora-c018fbb65ecb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.830618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.830965) ========= echo c018fbb65ecb505bc9e52fa617940ba8da5501b3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c018fbb65ecb505bc9e52fa617940ba8da5501b3'] 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c018fbb65ecb505bc9e52fa617940ba8da5501b3 program finished with exit code 0 elapsedTime=0.004167 script_repo_revision: 'c018fbb65ecb505bc9e52fa617940ba8da5501b3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.886083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.886542) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.899496) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.899796) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/c018fbb65ecb505bc9e52fa617940ba8da5501b3 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 09:28:54.900206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-21 09:28:54.900486) ========= /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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:55 INFO - MultiFileLogger online at 20160121 09:28:55 in /builds/slave/test-pgo 09:28:55 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 09:28:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:28:55 INFO - {'append_to_log': False, 09:28:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:28:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:28:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:28:55 INFO - 'branch': 'Mozilla-Aurora', 09:28:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:55 INFO - 'config_files': ('talos/linux_config.py',), 09:28:55 INFO - 'default_actions': ('clobber', 09:28:55 INFO - 'read-buildbot-config', 09:28:55 INFO - 'download-and-extract', 09:28:55 INFO - 'populate-webroot', 09:28:55 INFO - 'create-virtualenv', 09:28:55 INFO - 'install', 09:28:55 INFO - 'run-tests'), 09:28:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:55 INFO - 'download_minidump_stackwalk': True, 09:28:55 INFO - 'download_symbols': 'ondemand', 09:28:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:55 INFO - 'installer_path': 'installer.exe', 09:28:55 INFO - 'log_level': 'info', 09:28:55 INFO - 'log_name': 'talos', 09:28:55 INFO - 'log_to_console': True, 09:28:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:55 INFO - 'opt_config_files': (), 09:28:55 INFO - 'pip_index': False, 09:28:55 INFO - 'sps_profile': False, 09:28:55 INFO - 'sps_profile_interval': 0, 09:28:55 INFO - 'suite': 'dromaeojs-e10s', 09:28:55 INFO - 'system_bits': '32', 09:28:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:55 INFO - 'title': 'talos-linux64-ix-020', 09:28:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:55 INFO - 'use_talos_json': True, 09:28:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:28:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:55 INFO - 'work_dir': 'build'} 09:28:55 INFO - ##### 09:28:55 INFO - ##### Running clobber step. 09:28:55 INFO - ##### 09:28:55 INFO - Running pre-action listener: _resource_record_pre_action 09:28:55 INFO - Running main action method: clobber 09:28:55 INFO - rmtree: /builds/slave/test-pgo/build 09:28:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:28:55 INFO - Running post-action listener: _resource_record_post_action 09:28:55 INFO - ##### 09:28:55 INFO - ##### Running read-buildbot-config step. 09:28:55 INFO - ##### 09:28:55 INFO - Running pre-action listener: _resource_record_pre_action 09:28:55 INFO - Running main action method: read_buildbot_config 09:28:55 INFO - Using buildbot properties: 09:28:55 INFO - { 09:28:55 INFO - "properties": { 09:28:55 INFO - "buildnumber": 10, 09:28:55 INFO - "product": "firefox", 09:28:55 INFO - "script_repo_revision": "production", 09:28:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:28:55 INFO - "repository": "", 09:28:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:28:55 INFO - "buildid": "20160121070721", 09:28:55 INFO - "slavename": "talos-linux64-ix-020", 09:28:55 INFO - "pgo_build": "True", 09:28:55 INFO - "basedir": "/builds/slave/test-pgo", 09:28:55 INFO - "project": "", 09:28:55 INFO - "platform": "ubuntu64_hw", 09:28:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:28:55 INFO - "slavebuilddir": "test", 09:28:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:28:55 INFO - "branch": "mozilla-aurora", 09:28:55 INFO - "repo_path": "releases/mozilla-aurora", 09:28:55 INFO - "stage_platform": "linux64-pgo", 09:28:55 INFO - "builduid": "4acd06258fd44107ba4fa9f0cb53b611", 09:28:55 INFO - "revision": "c018fbb65ecb505bc9e52fa617940ba8da5501b3" 09:28:55 INFO - }, 09:28:55 INFO - "sourcestamp": { 09:28:55 INFO - "repository": "", 09:28:55 INFO - "hasPatch": false, 09:28:55 INFO - "project": "", 09:28:55 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:28:55 INFO - "changes": [ 09:28:55 INFO - { 09:28:55 INFO - "category": null, 09:28:55 INFO - "files": [ 09:28:55 INFO - { 09:28:55 INFO - "url": null, 09:28:55 INFO - "name": "https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 09:28:55 INFO - } 09:28:55 INFO - ], 09:28:55 INFO - "repository": "", 09:28:55 INFO - "rev": "c018fbb65ecb505bc9e52fa617940ba8da5501b3", 09:28:55 INFO - "who": "eakhgari@mozilla.com", 09:28:55 INFO - "when": 1453397072, 09:28:55 INFO - "number": 7493987, 09:28:55 INFO - "comments": "Bug 1237455 P5 Set headers on fetch() redirects. r=ehsan a=sylvestre\n", 09:28:55 INFO - "project": "", 09:28:55 INFO - "at": "Thu 21 Jan 2016 09:24:32", 09:28:55 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:28:55 INFO - "revlink": "", 09:28:55 INFO - "properties": [ 09:28:55 INFO - [ 09:28:55 INFO - "buildid", 09:28:55 INFO - "20160121070721", 09:28:55 INFO - "Change" 09:28:55 INFO - ], 09:28:55 INFO - [ 09:28:55 INFO - "builduid", 09:28:55 INFO - "4acd06258fd44107ba4fa9f0cb53b611", 09:28:55 INFO - "Change" 09:28:55 INFO - ], 09:28:55 INFO - [ 09:28:55 INFO - "pgo_build", 09:28:55 INFO - "True", 09:28:55 INFO - "Change" 09:28:55 INFO - ] 09:28:55 INFO - ], 09:28:55 INFO - "revision": "c018fbb65ecb505bc9e52fa617940ba8da5501b3" 09:28:55 INFO - } 09:28:55 INFO - ], 09:28:55 INFO - "revision": "c018fbb65ecb505bc9e52fa617940ba8da5501b3" 09:28:55 INFO - } 09:28:55 INFO - } 09:28:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 09:28:55 INFO - Running post-action listener: _resource_record_post_action 09:28:55 INFO - ##### 09:28:55 INFO - ##### Running download-and-extract step. 09:28:55 INFO - ##### 09:28:55 INFO - Running pre-action listener: _resource_record_pre_action 09:28:55 INFO - Running main action method: download_and_extract 09:28:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:28:55 INFO - https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/test_packages.json 09:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/test_packages.json 09:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:28:56 INFO - Downloaded 1302 bytes. 09:28:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:28:56 INFO - Using the following test package requirements: 09:28:56 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:28:56 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:28:56 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'jsshell-linux-x86_64.zip'], 09:28:56 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:28:56 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:28:56 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:28:56 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:28:56 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:28:56 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 09:28:56 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 09:28:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:28:56 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:28:56 INFO - https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:28:57 INFO - Downloaded 23159148 bytes. 09:28:57 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 09:28:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:57 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 09:28:58 INFO - Return code: 0 09:28:58 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 09:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:28:58 INFO - https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:28:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:28:59 INFO - Downloaded 23159148 bytes. 09:28:59 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 09:28:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 09:28:59 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 09:29:01 INFO - Return code: 0 09:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:01 INFO - https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:29:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:29:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:29:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:29:02 INFO - Downloaded 11132038 bytes. 09:29:02 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 09:29:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 09:29:02 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 09:29:02 INFO - Return code: 0 09:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:02 INFO - https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tLa9pncVT8qGSu8AsFpoUQ/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 09:29:06 INFO - Downloaded 58149182 bytes. 09:29:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:29:06 INFO - mkdir: /builds/slave/test-pgo/properties 09:29:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:29:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:29:06 INFO - Contents: 09:29:06 INFO - build_url:https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 09:29:06 INFO - Running post-action listener: _resource_record_post_action 09:29:06 INFO - Running post-action listener: set_extra_try_arguments 09:29:06 INFO - ##### 09:29:06 INFO - ##### Running populate-webroot step. 09:29:06 INFO - ##### 09:29:06 INFO - Running pre-action listener: _resource_record_pre_action 09:29:06 INFO - Running main action method: populate_webroot 09:29:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:06 INFO - '--tppagecycles', 09:29:06 INFO - '7'], 09:29:06 INFO - 'tests': ['tsvgm']}}, 09:29:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:29:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:29:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:29:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'tests': ['damp', 'tps']}, 09:29:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['damp', 'tps']}, 09:29:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:29:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:06 INFO - 'other': {'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'other_l64': {'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:29:06 INFO - 'ts_paint', 09:29:06 INFO - 'tpaint', 09:29:06 INFO - 'sessionrestore', 09:29:06 INFO - 'sessionrestore_no_auto_restore']}, 09:29:06 INFO - 'svgr': {'tests': ['tsvgx', 09:29:06 INFO - 'tsvgr_opacity', 09:29:06 INFO - 'tart', 09:29:06 INFO - 'tscrollx', 09:29:06 INFO - 'cart']}, 09:29:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['tsvgx', 09:29:06 INFO - 'tsvgr_opacity', 09:29:06 INFO - 'tart', 09:29:06 INFO - 'tscrollx', 09:29:06 INFO - 'cart']}, 09:29:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'tests': ['tp5o']}, 09:29:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'talos_options': ['--e10s'], 09:29:06 INFO - 'tests': ['tp5o']}, 09:29:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'talos_options': ['--xperf_path', 09:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:06 INFO - 'tests': ['tp5n']}, 09:29:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:06 INFO - 'talos_options': ['--e10s', 09:29:06 INFO - '--xperf_path', 09:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:06 INFO - 'tests': ['tp5n']}}, 09:29:06 INFO - 'talos.zip': {'path': '', 09:29:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:06 INFO - Running post-action listener: _resource_record_post_action 09:29:06 INFO - ##### 09:29:06 INFO - ##### Running create-virtualenv step. 09:29:06 INFO - ##### 09:29:06 INFO - Running pre-action listener: _resource_record_pre_action 09:29:06 INFO - Running main action method: create_virtualenv 09:29:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:29:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:29:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:29:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:06 INFO - Using real prefix '/usr' 09:29:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:29:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:08 INFO - Installing pip.................done. 09:29:08 INFO - Return code: 0 09:29:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:29:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:08 INFO - Using env: {'DISPLAY': ':0', 09:29:08 INFO - 'HOME': '/home/cltbld', 09:29:08 INFO - 'LANG': 'en_US.UTF-8', 09:29:08 INFO - 'LANGUAGE': 'en_US:en', 09:29:08 INFO - 'LOGNAME': 'cltbld', 09:29:08 INFO - 'MAIL': '/var/mail/cltbld', 09:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:08 INFO - 'MOZ_NO_REMOTE': '1', 09:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:08 INFO - 'NO_EM_RESTART': '1', 09:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:08 INFO - 'SHELL': '/bin/bash', 09:29:08 INFO - 'SHLVL': '1', 09:29:08 INFO - 'TERM': 'linux', 09:29:08 INFO - 'TMOUT': '86400', 09:29:08 INFO - 'USER': 'cltbld', 09:29:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:08 INFO - '_': '/tools/buildbot/bin/python'} 09:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:29:09 INFO - Cleaning up... 09:29:09 INFO - Return code: 0 09:29:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:29:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:29:09 INFO - Using env: {'DISPLAY': ':0', 09:29:09 INFO - 'HOME': '/home/cltbld', 09:29:09 INFO - 'LANG': 'en_US.UTF-8', 09:29:09 INFO - 'LANGUAGE': 'en_US:en', 09:29:09 INFO - 'LOGNAME': 'cltbld', 09:29:09 INFO - 'MAIL': '/var/mail/cltbld', 09:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:09 INFO - 'MOZ_NO_REMOTE': '1', 09:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:09 INFO - 'NO_EM_RESTART': '1', 09:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:09 INFO - 'SHELL': '/bin/bash', 09:29:09 INFO - 'SHLVL': '1', 09:29:09 INFO - 'TERM': 'linux', 09:29:09 INFO - 'TMOUT': '86400', 09:29:09 INFO - 'USER': 'cltbld', 09:29:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:09 INFO - '_': '/tools/buildbot/bin/python'} 09:29:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:09 INFO - Downloading/unpacking psutil>=0.7.1 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:11 INFO - Installing collected packages: psutil 09:29:11 INFO - Running setup.py install for psutil 09:29:11 INFO - building 'psutil._psutil_linux' extension 09:29:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:29:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:29:11 INFO - building 'psutil._psutil_posix' extension 09:29:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:29:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:29:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:11 INFO - Successfully installed psutil 09:29:11 INFO - Cleaning up... 09:29:11 INFO - Return code: 0 09:29:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:29:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:29:11 INFO - Using env: {'DISPLAY': ':0', 09:29:11 INFO - 'HOME': '/home/cltbld', 09:29:11 INFO - 'LANG': 'en_US.UTF-8', 09:29:11 INFO - 'LANGUAGE': 'en_US:en', 09:29:11 INFO - 'LOGNAME': 'cltbld', 09:29:11 INFO - 'MAIL': '/var/mail/cltbld', 09:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:11 INFO - 'MOZ_NO_REMOTE': '1', 09:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:11 INFO - 'NO_EM_RESTART': '1', 09:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:11 INFO - 'SHELL': '/bin/bash', 09:29:11 INFO - 'SHLVL': '1', 09:29:11 INFO - 'TERM': 'linux', 09:29:11 INFO - 'TMOUT': '86400', 09:29:11 INFO - 'USER': 'cltbld', 09:29:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:11 INFO - '_': '/tools/buildbot/bin/python'} 09:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:29:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:29:13 INFO - Installing collected packages: mozsystemmonitor 09:29:13 INFO - Running setup.py install for mozsystemmonitor 09:29:13 INFO - Successfully installed mozsystemmonitor 09:29:13 INFO - Cleaning up... 09:29:13 INFO - Return code: 0 09:29:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:29:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:29:13 INFO - Using env: {'DISPLAY': ':0', 09:29:13 INFO - 'HOME': '/home/cltbld', 09:29:13 INFO - 'LANG': 'en_US.UTF-8', 09:29:13 INFO - 'LANGUAGE': 'en_US:en', 09:29:13 INFO - 'LOGNAME': 'cltbld', 09:29:13 INFO - 'MAIL': '/var/mail/cltbld', 09:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:13 INFO - 'MOZ_NO_REMOTE': '1', 09:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:13 INFO - 'NO_EM_RESTART': '1', 09:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:13 INFO - 'SHELL': '/bin/bash', 09:29:13 INFO - 'SHLVL': '1', 09:29:13 INFO - 'TERM': 'linux', 09:29:13 INFO - 'TMOUT': '86400', 09:29:13 INFO - 'USER': 'cltbld', 09:29:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:13 INFO - '_': '/tools/buildbot/bin/python'} 09:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:29:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:16 INFO - Downloading docopt-0.6.1.tar.gz 09:29:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:16 INFO - Running setup.py install for blobuploader 09:29:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:29:16 INFO - Running setup.py install for requests 09:29:17 INFO - Running setup.py install for docopt 09:29:17 INFO - Successfully installed blobuploader requests docopt 09:29:17 INFO - Cleaning up... 09:29:17 INFO - Return code: 0 09:29:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:29:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:17 INFO - Using env: {'DISPLAY': ':0', 09:29:17 INFO - 'HOME': '/home/cltbld', 09:29:17 INFO - 'LANG': 'en_US.UTF-8', 09:29:17 INFO - 'LANGUAGE': 'en_US:en', 09:29:17 INFO - 'LOGNAME': 'cltbld', 09:29:17 INFO - 'MAIL': '/var/mail/cltbld', 09:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:17 INFO - 'MOZ_NO_REMOTE': '1', 09:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:17 INFO - 'NO_EM_RESTART': '1', 09:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:17 INFO - 'SHELL': '/bin/bash', 09:29:17 INFO - 'SHLVL': '1', 09:29:17 INFO - 'TERM': 'linux', 09:29:17 INFO - 'TMOUT': '86400', 09:29:17 INFO - 'USER': 'cltbld', 09:29:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:17 INFO - '_': '/tools/buildbot/bin/python'} 09:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:29:17 INFO - Running setup.py (path:/tmp/pip-Bfhbvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:29:17 INFO - Running setup.py (path:/tmp/pip-NApfDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:29:17 INFO - Running setup.py (path:/tmp/pip-5SgnJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:29:17 INFO - Running setup.py (path:/tmp/pip-AE296k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:29:17 INFO - Running setup.py (path:/tmp/pip-ax72EK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:29:17 INFO - Running setup.py (path:/tmp/pip-xFjEwP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:29:17 INFO - Running setup.py (path:/tmp/pip-m1QhBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:29:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:29:17 INFO - Running setup.py (path:/tmp/pip-ReeYgg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:29:18 INFO - Running setup.py (path:/tmp/pip-X2lljv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:29:18 INFO - Running setup.py (path:/tmp/pip-PkaBj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:29:18 INFO - Running setup.py (path:/tmp/pip-1fav5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:29:18 INFO - Running setup.py (path:/tmp/pip-iewVv4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:29:18 INFO - Running setup.py (path:/tmp/pip-jijdnT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:29:18 INFO - Running setup.py (path:/tmp/pip-KLJYYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:29:18 INFO - Running setup.py (path:/tmp/pip-ysqvAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:29:18 INFO - Running setup.py (path:/tmp/pip-ZqRysZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:29:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:29:18 INFO - Running setup.py (path:/tmp/pip-gZKsBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:29:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:18 INFO - Running setup.py install for manifestparser 09:29:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:29:18 INFO - Running setup.py install for mozcrash 09:29:18 INFO - Running setup.py install for mozdebug 09:29:19 INFO - Running setup.py install for mozdevice 09:29:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for mozfile 09:29:19 INFO - Running setup.py install for mozhttpd 09:29:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for mozinfo 09:29:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for mozInstall 09:29:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for mozleak 09:29:19 INFO - Running setup.py install for mozlog 09:29:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for moznetwork 09:29:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:29:19 INFO - Running setup.py install for mozprocess 09:29:19 INFO - Running setup.py install for mozprofile 09:29:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:29:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:29:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:29:20 INFO - Running setup.py install for mozrunner 09:29:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:29:20 INFO - Running setup.py install for mozscreenshot 09:29:20 INFO - Running setup.py install for moztest 09:29:20 INFO - Running setup.py install for mozversion 09:29:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:29:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:20 INFO - Cleaning up... 09:29:20 INFO - Return code: 0 09:29:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:29:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:20 INFO - Using env: {'DISPLAY': ':0', 09:29:20 INFO - 'HOME': '/home/cltbld', 09:29:20 INFO - 'LANG': 'en_US.UTF-8', 09:29:20 INFO - 'LANGUAGE': 'en_US:en', 09:29:20 INFO - 'LOGNAME': 'cltbld', 09:29:20 INFO - 'MAIL': '/var/mail/cltbld', 09:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:20 INFO - 'MOZ_NO_REMOTE': '1', 09:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:20 INFO - 'NO_EM_RESTART': '1', 09:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:20 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:20 INFO - 'SHELL': '/bin/bash', 09:29:20 INFO - 'SHLVL': '1', 09:29:20 INFO - 'TERM': 'linux', 09:29:20 INFO - 'TMOUT': '86400', 09:29:20 INFO - 'USER': 'cltbld', 09:29:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:20 INFO - '_': '/tools/buildbot/bin/python'} 09:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:29:20 INFO - Running setup.py (path:/tmp/pip-VRvVXr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:29:20 INFO - Running setup.py (path:/tmp/pip-qKO3dm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:29:20 INFO - Running setup.py (path:/tmp/pip-xylilc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:29:20 INFO - Running setup.py (path:/tmp/pip-opKDfz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:29:21 INFO - Running setup.py (path:/tmp/pip-l9cZGL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:29:21 INFO - Running setup.py (path:/tmp/pip-tHrs7I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:29:21 INFO - Running setup.py (path:/tmp/pip-tyLvNT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:29:21 INFO - Running setup.py (path:/tmp/pip-2w2OpQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:29:21 INFO - Running setup.py (path:/tmp/pip-VvC_6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:29:21 INFO - Running setup.py (path:/tmp/pip-KdvNXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:29:21 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)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:29:21 INFO - Running setup.py (path:/tmp/pip-0kfBQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:29:21 INFO - Running setup.py (path:/tmp/pip-qAeUHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:29:21 INFO - Running setup.py (path:/tmp/pip-Ebebo9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:29:21 INFO - Running setup.py (path:/tmp/pip-5rg9E3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:29:21 INFO - Running setup.py (path:/tmp/pip-ZBGDgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:29:21 INFO - Running setup.py (path:/tmp/pip-EkR5nb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:29:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:29:21 INFO - Running setup.py (path:/tmp/pip-Vd6z3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:23 INFO - Downloading blessings-1.6.tar.gz 09:29:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:23 INFO - Installing collected packages: blessings 09:29:23 INFO - Running setup.py install for blessings 09:29:23 INFO - Successfully installed blessings 09:29:23 INFO - Cleaning up... 09:29:23 INFO - Return code: 0 09:29:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:29:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:29:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:29:24 INFO - Reading from file tmpfile_stdout 09:29:24 INFO - Current package versions: 09:29:24 INFO - argparse == 1.2.1 09:29:24 INFO - blessings == 1.6 09:29:24 INFO - blobuploader == 1.2.4 09:29:24 INFO - docopt == 0.6.1 09:29:24 INFO - manifestparser == 1.1 09:29:24 INFO - mozInstall == 1.12 09:29:24 INFO - mozcrash == 0.16 09:29:24 INFO - mozdebug == 0.1 09:29:24 INFO - mozdevice == 0.47 09:29:24 INFO - mozfile == 1.2 09:29:24 INFO - mozhttpd == 0.7 09:29:24 INFO - mozinfo == 0.9 09:29:24 INFO - mozleak == 0.1 09:29:24 INFO - mozlog == 3.1 09:29:24 INFO - moznetwork == 0.27 09:29:24 INFO - mozprocess == 0.22 09:29:24 INFO - mozprofile == 0.27 09:29:24 INFO - mozrunner == 6.11 09:29:24 INFO - mozscreenshot == 0.1 09:29:24 INFO - mozsystemmonitor == 0.0 09:29:24 INFO - moztest == 0.7 09:29:24 INFO - mozversion == 1.4 09:29:24 INFO - psutil == 3.1.1 09:29:24 INFO - requests == 1.2.3 09:29:24 INFO - wsgiref == 0.1.2 09:29:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:29: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')]} 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:29:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:24 INFO - Using env: {'DISPLAY': ':0', 09:29:24 INFO - 'HOME': '/home/cltbld', 09:29:24 INFO - 'LANG': 'en_US.UTF-8', 09:29:24 INFO - 'LANGUAGE': 'en_US:en', 09:29:24 INFO - 'LOGNAME': 'cltbld', 09:29:24 INFO - 'MAIL': '/var/mail/cltbld', 09:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:24 INFO - 'MOZ_NO_REMOTE': '1', 09:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:24 INFO - 'NO_EM_RESTART': '1', 09:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:24 INFO - 'SHELL': '/bin/bash', 09:29:24 INFO - 'SHLVL': '1', 09:29:24 INFO - 'TERM': 'linux', 09:29:24 INFO - 'TMOUT': '86400', 09:29:24 INFO - 'USER': 'cltbld', 09:29:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:24 INFO - '_': '/tools/buildbot/bin/python'} 09:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:29:24 INFO - Cleaning up... 09:29:24 INFO - Return code: 0 09:29:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:29: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')]} 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 09:29:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 09:29:24 INFO - Using env: {'DISPLAY': ':0', 09:29:24 INFO - 'HOME': '/home/cltbld', 09:29:24 INFO - 'LANG': 'en_US.UTF-8', 09:29:24 INFO - 'LANGUAGE': 'en_US:en', 09:29:24 INFO - 'LOGNAME': 'cltbld', 09:29:24 INFO - 'MAIL': '/var/mail/cltbld', 09:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:24 INFO - 'MOZ_NO_REMOTE': '1', 09:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:24 INFO - 'NO_EM_RESTART': '1', 09:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:24 INFO - 'SHELL': '/bin/bash', 09:29:24 INFO - 'SHLVL': '1', 09:29:24 INFO - 'TERM': 'linux', 09:29:24 INFO - 'TMOUT': '86400', 09:29:24 INFO - 'USER': 'cltbld', 09:29:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:24 INFO - '_': '/tools/buildbot/bin/python'} 09:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:24 INFO - Downloading/unpacking jsonschema 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:26 INFO - Downloading/unpacking functools32 (from jsonschema) 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:26 INFO - warning: no files found matching '*.txt' 09:29:26 INFO - no previously-included directories found matching 'build' 09:29:26 INFO - no previously-included directories found matching 'dist' 09:29:26 INFO - no previously-included directories found matching '.git*' 09:29:26 INFO - Installing collected packages: jsonschema, functools32 09:29:26 INFO - Running setup.py install for functools32 09:29:26 INFO - warning: no files found matching '*.txt' 09:29:26 INFO - no previously-included directories found matching 'build' 09:29:26 INFO - no previously-included directories found matching 'dist' 09:29:26 INFO - no previously-included directories found matching '.git*' 09:29:26 INFO - Successfully installed jsonschema functools32 09:29:26 INFO - Cleaning up... 09:29:26 INFO - Return code: 0 09:29:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:29: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')]} 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4d4bb7df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1136450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, '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': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 09:29:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 09:29:26 INFO - Using env: {'DISPLAY': ':0', 09:29:26 INFO - 'HOME': '/home/cltbld', 09:29:26 INFO - 'LANG': 'en_US.UTF-8', 09:29:26 INFO - 'LANGUAGE': 'en_US:en', 09:29:26 INFO - 'LOGNAME': 'cltbld', 09:29:26 INFO - 'MAIL': '/var/mail/cltbld', 09:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:26 INFO - 'MOZ_NO_REMOTE': '1', 09:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:26 INFO - 'NO_EM_RESTART': '1', 09:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:26 INFO - 'SHELL': '/bin/bash', 09:29:26 INFO - 'SHLVL': '1', 09:29:26 INFO - 'TERM': 'linux', 09:29:26 INFO - 'TMOUT': '86400', 09:29:26 INFO - 'USER': 'cltbld', 09:29:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:26 INFO - '_': '/tools/buildbot/bin/python'} 09:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:27 INFO - Downloading/unpacking flake8 09:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:29:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:29:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:29:29 INFO - no previously-included directories found matching 'docs/_build' 09:29:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:29:29 INFO - Running setup.py install for pep8 09:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:29:29 INFO - no previously-included directories found matching 'docs/_build' 09:29:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:29:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:29:29 INFO - Cleaning up... 09:29:29 INFO - Return code: 0 09:29:29 INFO - Running post-action listener: _resource_record_post_action 09:29:29 INFO - Running post-action listener: _start_resource_monitoring 09:29:29 INFO - Starting resource monitoring. 09:29:29 INFO - ##### 09:29:29 INFO - ##### Running install step. 09:29:29 INFO - ##### 09:29:29 INFO - Running pre-action listener: _resource_record_pre_action 09:29:29 INFO - Running main action method: install 09:29:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:29:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:29:29 INFO - Reading from file tmpfile_stdout 09:29:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:29:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:29:30 INFO - Reading from file tmpfile_stdout 09:29:30 INFO - Output received: 09:29:30 INFO - Usage: mozinstall [options] installer 09:29:30 INFO - Options: 09:29:30 INFO - -h, --help show this help message and exit 09:29:30 INFO - -d DEST, --destination=DEST 09:29:30 INFO - Directory to install application into. [default: 09:29:30 INFO - "/builds/slave/test-pgo"] 09:29:30 INFO - --app=APP Application being installed. [default: firefox] 09:29:30 INFO - mkdir: /builds/slave/test-pgo/build/application 09:29:30 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'] 09:29:30 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 09:29:46 INFO - Reading from file tmpfile_stdout 09:29:46 INFO - Output received: 09:29:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:29:46 INFO - Running post-action listener: _resource_record_post_action 09:29:46 INFO - ##### 09:29:46 INFO - ##### Running run-tests step. 09:29:46 INFO - ##### 09:29:46 INFO - Running pre-action listener: _resource_record_pre_action 09:29:46 INFO - Running main action method: run_tests 09:29:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:29:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:29:46 INFO - Python 2.7.3 09:29:46 INFO - Return code: 0 09:29:46 INFO - grabbing minidump binary from tooltool 09:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:46 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 0x11c8a50>, '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 0x1134550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11349e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:29:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:29:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:29:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:46 INFO - Return code: 0 09:29:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:29:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:29:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:29:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:29:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:29:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:29:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:29:47 INFO - Return code: 0 09:29:47 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/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:29:47 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/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost 09:29:47 INFO - Using env: {'DISPLAY': ':0', 09:29:47 INFO - 'HOME': '/home/cltbld', 09:29:47 INFO - 'LANG': 'en_US.UTF-8', 09:29:47 INFO - 'LANGUAGE': 'en_US:en', 09:29:47 INFO - 'LOGNAME': 'cltbld', 09:29:47 INFO - 'MAIL': '/var/mail/cltbld', 09:29:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:29:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:47 INFO - 'MOZ_NO_REMOTE': '1', 09:29:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:47 INFO - 'NO_EM_RESTART': '1', 09:29:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:29:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:29:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:29:47 INFO - 'SHELL': '/bin/bash', 09:29:47 INFO - 'SHLVL': '1', 09:29:47 INFO - 'TERM': 'linux', 09:29:47 INFO - 'TMOUT': '86400', 09:29:47 INFO - 'USER': 'cltbld', 09:29:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704', 09:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:47 INFO - '_': '/tools/buildbot/bin/python'} 09:29:47 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/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost'] with output_timeout 3600 09:29:47 INFO - mozversion INFO | application_buildid: 20160121070721 09:29:47 INFO - mozversion INFO | application_changeset: c018fbb65ecb505bc9e52fa617940ba8da5501b3 09:29:47 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:29:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:47 INFO - mozversion INFO | application_name: Firefox 09:29:47 INFO - mozversion INFO | application_remotingname: firefox-dev 09:29:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:29:47 INFO - mozversion INFO | application_vendor: Mozilla 09:29:47 INFO - mozversion INFO | application_version: 45.0a2 09:29:47 INFO - mozversion INFO | platform_buildid: 20160121070721 09:29:47 INFO - mozversion INFO | platform_changeset: c018fbb65ecb505bc9e52fa617940ba8da5501b3 09:29:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:29:47 INFO - mozversion INFO | platform_version: 45.0a2 09:29:47 INFO - 2016-01-21 09:29:47,874 DEBUG : using testdate: 1453397387 09:29:47 INFO - 2016-01-21 09:29:47,874 DEBUG : actual date: 1453397387 09:29:47 INFO - 2016-01-21 09:29:47,922 INFO : starting webserver on 'localhost:41806' 09:29:47 INFO - 2016-01-21 09:29:47,923 INFO : Starting test suite talos-linux64-ix-020.e 09:29:47 INFO - 2016-01-21 09:29:47,923 INFO : Starting test dromaeo_css 09:29:47 INFO - 2016-01-21 09:29:47,923 DEBUG : operating with platform_type : linux_ 09:29:47 INFO - 2016-01-21 09:29:47,924 INFO : Initialising browser for dromaeo_css test... 09:29:47 INFO - 2016-01-21 09:29:47,936 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVW0o4z/profile http://localhost:41806/getInfo.html 09:29:52 INFO - 2016-01-21 09:29:52,238 DEBUG : BROWSER_OUTPUT: 09:29:52 INFO - 2016-01-21 09:29:52,239 DEBUG : BROWSER_OUTPUT: (process:22997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:29:53 INFO - 2016-01-21 09:29:53,290 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:29:53 INFO - 2016-01-21 09:29:53,290 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:29:53 INFO - 2016-01-21 09:29:53,290 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:29:53 INFO - 2016-01-21 09:29:53,290 DEBUG : BROWSER_OUTPUT: __metrics 09:29:54 INFO - 2016-01-21 09:29:54,357 INFO : Browser initialized. 09:29:54 INFO - 2016-01-21 09:29:54,358 INFO : Running cycle 1/1 for dromaeo_css test... 09:29:54 INFO - 2016-01-21 09:29:54,358 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVW0o4z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:29:55 INFO - 2016-01-21 09:29:55,603 DEBUG : BROWSER_OUTPUT: 09:29:55 INFO - 2016-01-21 09:29:55,603 DEBUG : BROWSER_OUTPUT: (process:23111): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:30:06 INFO - 2016-01-21 09:30:06,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 136318976 09:30:06 INFO - 2016-01-21 09:30:06,111 DEBUG : BROWSER_OUTPUT: 09:30:55 INFO - 2016-01-21 09:30:55,722 DEBUG : BROWSER_OUTPUT: 1453397455719 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:33:03 INFO - 2016-01-21 09:33:03,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41806/tests/dromaeo/cssquery-ext.html) 09:33:04 INFO - 2016-01-21 09:33:04,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 141602816 09:33:04 INFO - 2016-01-21 09:33:04,788 DEBUG : BROWSER_OUTPUT: 09:36:06 INFO - 2016-01-21 09:36:06,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-ext.html (next: http://localhost:41806/tests/dromaeo/cssquery-jquery.html) 09:36:07 INFO - 2016-01-21 09:36:07,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 139755520 09:36:07 INFO - 2016-01-21 09:36:07,326 DEBUG : BROWSER_OUTPUT: 09:39:08 INFO - 2016-01-21 09:39:08,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41806/tests/dromaeo/cssquery-mootools.html) 09:39:09 INFO - 2016-01-21 09:39:09,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 138203136 09:39:09 INFO - 2016-01-21 09:39:09,548 DEBUG : BROWSER_OUTPUT: 09:42:11 INFO - 2016-01-21 09:42:11,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41806/tests/dromaeo/cssquery-prototype.html) 09:42:11 INFO - 2016-01-21 09:42:11,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 139620352 09:42:11 INFO - 2016-01-21 09:42:11,725 DEBUG : BROWSER_OUTPUT: 09:45:13 INFO - 2016-01-21 09:45:13,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41806/tests/dromaeo/cssquery-yui.html) 09:45:14 INFO - 2016-01-21 09:45:14,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 140443648 09:45:14 INFO - 2016-01-21 09:45:14,538 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/dromaeo/cssquery-yui.html (next: http://localhost:41806/tests/dromaeo/cssquery-dojo.html) 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:48:16 INFO - 2016-01-21 09:48:16,873 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3349.581302337208;3362.8822991195298;3365.5961284645846;3392.643772403897;3400.098973771951;5529.806456774014;5531.557475401958;5536.916946245809;5544.1960915667205;5550.611457197998;5493.533049690771;5533.584981126422;5545.306836645419;5546.86132846678;5563.944360556393;5040.294358789773;5041.6974981501135;5131.435542090367;5146.819861304855;5182.481751824825;4901.901961960759;4974;5021.799128034874;5022.573081288095;5040.672356296847;4987.202047672373;5036.11867923112;5039.067772462106;5068.366454193226;5101.183810590306;5129.102407078765;5150.510701483353;5171.172612382001;5175.689458632494;5185.688858668492;4781.976090119562;4825;4875.268709693539;5048.823291184827;5057.595392368638;5200.765965531522;5230.372355317349;5262.736863156865;5264.947350526484;5267.552258058031;5890.528757699417;5922.8815423691285;5987.790427335066;5989.251343582052;6003.549733769984;5985.940140598582;5988.31134419543;6018.548608854309;6042.57701960863;6050.183225264621;5334.359876814807;5411.404745477994;5460.31746031746;5545.362283337387;5584.301962254718;6004.0693692477735;6031.788887388921;6076.787312444043;6097.847553811191;6105.053716673922;5647.350554686182;5844.211031510777;5868.618539794899;5868.765249390062;5875.970620146872;5752;5777.508911742465;5780.479756821906;5819.563532735062;5921.171036054956;5894.0274854648505;5922.96348139074;5927.962606543838;5944.881102377928;5950.464458198783;5674.546036317085;5797.826065218051;5898.616589921641;5948.494377977834;5951.3751056139345;4527.139843429738;4531.297648864432;4533.569310915458;4609.446866375989;4668.019715859639;4109.157622687342;4113.403556484293;4126.195391898551;4129.876103716893;4162.313218319004;5520.392756796749;5741.712914354265;5758.568107391962;5766.740496677659;5788.102844059177;5753.367129615739;5977.731002104916;6082.695865206722;6087.6956152192215;6107.633541987495;5641.830745077655;5645.604807663506;5674.177244299636;5675.3757086720425;5682.573806964494;5002.799888004512;5104.3874735031295;5121.923171152435;5151.665141765773;5161.716105614228;6107.450329470369;6189.442950134509;6191;6196.10156527301;6223.346548612421;6013.188219590299;6017;6019.789307374221;6023.126646636126;6054.8183554493435;6034.125051867367;6074.119252708421;6103.450689437972;6112.989854784201;6154.015357542772;5970.880582388415;5973.01445261527;5981.820545383645;5990.371011043778;5999;6009.759609615567;6033.5173186145885;6038.5772995889865;6055.666938318434;6066.272047354346;5637.2107904894165;5698.2592263005545;5821.068629019336;5908.291005079418;5975.40245975399;5906.291245050621;5924.289085309618;5931.525477961839;5940.227770389822;5942.762289508371;5820.679862607597;5846.210761547137;5853.385394533512;5854.824355269348;5859.794907178229;5646.971765141148;5669.20631111653;5695.572832037531;5785.8139081489035;5796.565257605781;5739.598228123991;5756.107803290497;5792.652440853562;5803.158542011469;5824.097264923944 09:48:16 INFO - 2016-01-21 09:48:16,874 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.46861652971;606.1453350775407;607.489708644738;638.2086213095761;643.8004218692205;38441.423378649306;38944.41583376252;38947;38950;38977;44851;45803.083938321215;45854.31218531725;46115.53884461155;46119.769401152946;9014.188723014911;9202.217811486033;9231.58457869394;9238.445693258393;9247.306452016126;8893.77765555863;8950.328725345593;8966.641334346617;8976.551172441385;9004.324675649352;9042.367034307601;9096.954515227415;9114.86327705085;9137.223336016446;9178.128077832629;8926.37515373924;9049.864252036225;9104.453732776055;9134.223590994774;9134.497602631853;8941.374103812735;9005.189532942;9009.189172974398;9021.819563608757;9049.140331668481;43600;44192.11615767699;44281;44294.114117717465;44353.334699979525;3766.9246615067545;3816.46569480273;3841.9231615367817;3853.441251018615;4246.957530424687;36771;36969.63030369689;37203.4419483708;37241.62758372409;37242.44136337957;3964.6088080326017;4035.4955630546183;4039.2931237033695;4102.897427564305;4119.134981653856;313420;314989;315590;316597;318056.40971795225;45175.322370164475;46042.30936535955;46092.3086153708;68675;68981;43377.56622433735;43516.564834351884;43643;43808.56191438108;43845.561544384145;17020.744688829676;17082.57293567646;17252.309907603805;17266;17278.395256166226;13682.384292706853;13822.585322440344;13824.585262442142;13830.930845345709;13839.654008649864;15608.609784755472;15617.297221625055;15634.53096407087;15748.606284842741;15753.291101900442;6028.698565071729;6035.245594300713;6078.6048906820915;6152.3540028297275;6247.187865577536;998.1864780204111;1009.7627057641448;1015.4262841494532;1070.3256948122632;1086.6848613902039;30052;34633.134171645914;34876.825615871756;35024.29951400957;35305.82347088299;1120.0871289898869;1127.2222166704948;1140.4367862948677;1156.462245056053;1179.4279774309452;15183.696326073417;15265.313060912285;15337.539873803804;17465.563360915825;18419.72370414445;514119;540279;540285;661296;678661;61360;61986.38013619896;62160.68919655373;62292.37707622956;62360.37639623546;1428.3429622373617;1438.0868148725845;1464.3922772049693;1537.6463413414976;1610.5973506623345;30937.535936961413;32128.35743285168;32821.835890820395;34172.31655366928;34526.48210276798;55052;55135.44864551303;55357.72321138369;55695.16457253064;55717.72141139268;335614;340308;341047;342074;344490;45705.77147114376;46331.53668463407;47193.528064718914;47495.287570685774;48347.27479087746;46714.532854672376;47127.76436117797;47414.28878566755;47792.76103619599;48304.275435867785;39219.21561568695;40068.7996560027;40691.389629155;40950.385744213265;41040.794796027025;43172.352414714434;44869.77565112284;45639.31541026953;47500.52499474961;48195.277070843265;39732.801335993136;39908.401373978835;40006.59993400029;40198.59801401949;40301.39547906725;34673.30653386968;34702.82648586741;34839.825800870836;38530;40104.79947600243;27054.323641908322;27268.863655681595;27276.454470910867;27334.589981150697;27486.587701184097 09:48:16 INFO - 2016-01-21 09:48:16,874 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.8037500874555;385.3814627522826;385.77624977513045;388.2177412513787;389.5578518381638;16209.351625934978;17369.565760855952;17446.476605701835;20011.399658010247;20128.69806952895;12377.443015064344;12417.56538521152;12429.31638759868;17137.400190993318;17550.210240539174;4758.405199350082;5150.922736158961;5215.295935048758;5277.366715994086;5675.2054712340305;4713.646476514258;5143.871403214912;5223.399309079447;5269.104252277103;5278.762455689484;5178.637495375326;5216.921746173811;5230.398504172012;5233.188855727369;5579.581531385163;5610.158476228557;5611.102223644218;5619.690916999563;5636.7463464144;5647.689377084259;5204.661696989721;5375.11310633745;5376.247325374451;5401.135818269058;5444.96545656324;13447.731045379038;13647.181169129784;13700.3834827433;16857.747133793004;21541.78458215429;2266.3994041578994;2285.897134628946;2342.4143964009;2374.358923090756;2375.67928329675;10051.648192313234;10101.49492525378;10367.066963973202;10397.688069357931;10554.736131596695;1993.990030049855;2010.7989201079922;2025.6252593270292;2032.3293313206607;2052.0868213644935;66558.00162997608;66568.33431665719;67388.3261167387;68467.65766171187;69764.6511767443;11023.17326200522;11156.944215278872;11208;11226.045786108272;11232;14786.926065369604;14854.925725371304;14937.775933361008;14945.02857314271;14967;8210.343172546181;8420.705275315335;8704.303655707528;8714.433561818461;8724.476531408009;8595.269402100766;8647.221750042527;8648.351373647001;8662.094339245356;8672.436291641023;4685.273782563708;4757.333973243749;4782.067496838084;4796.208625576741;4828.637852161102;1910.6274276516224;1910.6942889137672;1933.3083551892094;1935.4774210962962;1963.3619073801071;905.2667339455063;963.6868017894212;973.4402718436786;977.296346630425;999.985045089057;15437.459688910834;16469.68242540594;17746.46760597184;18212.817871821113;18619.06904654789;998.6904059741504;1011.2567263061644;1025.8102251083574;1040.1782591752583;1058.264506168221;10281.485925703684;10397;10420.114290285259;10420.947895260626;10477.68566942993;574353;576850;592769;600018;602857;84785;85439;85582.71625925617;87862;88228;1120.3278033180027;1134.0813940708053;1143.108375467137;1144.5765066925292;1148.7530181010954;16172.514824555283;16219;16532.173391330627;16583.50249492517;16692.165391730607;37749;37904;37980.620193798815;38026.61973380342;38471.615283846804;50477.74761126171;50909.745451273986;51090.23364649459;51991;53166.2025069632;10524.052835244558;10605.363678179334;10653.041226289672;10726.624568140078;10744.623938162127;11908;17261.827381726525;17973.550661233574;18166.818331816514;18547.536311592317;15625.76561351558;16042.197890105215;16123.193840307704;16239.431619893247;16370.918145409196;14525.78211326852;14942.775858361916;15214.695706086037;15260.389584416498;15634.06195628266;15330.310136044129;15444;15543.611409714847;15875.52373428799;16087.517374478784;9716.3198576099;9719.17387022111;9845.261605379483;10071;10123.088921997056;10256.58973641046;10267.127294180078;12159.81760273579;15367.61580960485;15818.841811581737 09:48:16 INFO - 2016-01-21 09:48:16,877 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1486.95539133826;1542.861142497175;1623.3831144165215;1717.957051073723;1842.4012196036292;7785.844283114335;7807.297343239107;7894.684212631488;7967.88048179277;7974.601269936509;7997.200279972;8016.038075430956;8043.758687239378;8074.51552906826;8103.3922455815755;2189.6058709432295;2220.467087898901;2228.9108435662556;2231.8102961248233;2233.039792889057;2327.8952447139836;2367.396313939943;2369.0168580039262;2369.123424332999;2369.3365857559825;2283.1666441748725;2318.3972167236557;2327.011020316367;2337.497438050819;2366.432056306491;2314.467672435341;2342.2153578551206;2350.7296660884044;2350.882455877208;2359.091749676387;2345.2495201535517;2367.6803631509697;2387.08097382509;2389.7371289158177;2402.1112188490197;7856.528608283465;7864.488808227504;7937.484063535851;7937.642806073741;7939.880901786478;4768.094062128184;4811;4829.541193586604;4843.515648435164;4853.781579828881;3059.571659967606;3116.6104236970377;3118.6257649082027;3127.3119913618966;3140.120766185472;951.728757304172;965.0783501755807;975.5658731864323;981.6466072213997;1007.9567647484818;10425.218108641882;10503.10723588496;10513.421761803098;10535.262531622866;10552.630657926935;4228.70399072062;4246.957530424718;4260.318349064135;4272.380504826782;4313.029568347097;8748.387612867165;8753.431026983226;8763.298936085097;8771.824563508693;8782.165694259034;4782.187028205144;4787.736674482867;4803.879903002453;4821.879453013703;4821.9035619287415;4359.17175736609;4369.344598310279;4373.037931655031;4396.450443694538;4414.139242847678;3525.524054252643;3571.1072231942017;3578.6958108561066;3596.7662101963288;3607.1703508193264;1076.8976947190004;1089.9481999870163;1097.182598963777;1100.4937728644752;1108.1578000719512;980.838161703311;1015.7562185075528;1035.5236591168148;1107.429673718036;1225.3383173086434;7044.401225895856;7048.823779405556;7061.9293807062295;7067.5052746307265;7115.146182458138;1104.5140138339266;1135.0917681084768;1144.3934714601276;1150.3328069719544;1161.1929708852267;5564.443555644484;5567.860803479945;5590.608657393944;5613.887722245532;5619.016672082369;8795.648174072965;9317.254619630414;9368;9479.526023698787;9522.619095236112;9185.127412895765;9209.171174594185;9282.582283797245;9353.251739860794;9379.859302110473;7137.1435427749;7395.741149059757;7407.925920740724;7440.813979650444;7465.962670186615;7108.07595012645;7124.536905101152;7134.750283740044;7151.463640227108;7170.820729481805;8063.596820158851;8109.553974531457;8322.750317490485;8417.494950303002;8435.24082832548;8222.588870556328;8370.87443688333;8439.493630382196;8447.704330348408;8455.492670439793;7080.079589653518;7126.2873712628325;7165.3551180394015;7192.244814294424;7216.530925489827;7619.580923049064;7637.961810190914;7646.694132234648;7656.655450504629;7692.7692169235015;6744.5616034957575;6961.7215311389;6976.232614412512;7123.216446191019;7128.429725622042;6815.795526134224;7009.614471204132;7060.399866011447;7069.505134640732;7187.31720486553;7076.681549330189;7101.8579628406105;7107.893381599383;7127.893081603884;7145.4998150128995;6313.873722525432;6346.397092276226;6364.459020983269;6366.9044964326495;6400.359964003748;6378.6810659467765;6427.196600424947;6490.3185165558825;6493.8701225976165;6500.219973603198 09:48:16 INFO - 2016-01-21 09:48:16,877 DEBUG : BROWSER_OUTPUT: |4;prototype.html;354.05114293692924;354.18360678635753;358.56255368450496;358.7524608020466;361.8498323195873;6408.679566021698;6423.3897779710915;6447.838804029896;6454.354564543543;6588;6351.968240158804;6389.361063893608;6400.647964361959;6408.519361047916;6424.5502814802985;4808.807647694088;4829.637777166709;4831.251156070814;4838.927416088762;4841.3222148899185;4834.371531700892;4840.443349014873;4850.878728031792;4855.635827312948;4856.902861942759;4650.046740418206;4775.021120670254;4776.044791041805;4776.68951518152;4795.376601041877;4738.6446016548725;4753.928691069636;4757.1437141314545;4765.237561990082;4774.116788394158;4154.709170358076;4167.5832416758385;4169;4171.228322760268;4177.248095342837;6017.669028203447;6018.8194354169445;6024.819255422344;6029.969850150765;6035.155078288999;5508;5577.776888924438;5582.302212223472;5583.274174357348;5587.413321601254;6624.238212605564;6684.766033188815;6696.1629796275465;6699.363560461748;6704;4617.468991066037;4621.30680397943;4621.329907163443;4622.237330840408;4639;6869.416099631538;6937.861242775167;6969.9303006969785;7025.613591252479;7039.436845052383;4700.45944716362;4707.29390591414;4709.081729062868;4709.152352576501;4710.481846996828;4775.761211939389;4788.904221915543;4792.688475249098;4795.544423279783;4808.543188397097;5577.107662773937;5579.888402231933;5583.134614134816;5593.049181639131;5594.524465420403;6722.66386680664;6760.7295708172105;6769.255381907986;6784.457243420515;6797;1662.5760431089996;1686.4856218853122;1707.7694511241073;1708.6924353616469;1716.3392094043634;1119.2221406122828;1134.2003887259461;1140.8573928258968;1143.2683082826998;1152.3374059915582;6574.3754343337305;6579.8026059217345;6592.30780768022;6596.901046484307;6605.042268870987;6877.105976223059;6936.2023367312395;6952.930470695228;6958.930410695828;6964.512484126062;6514.250861151028;6538.934610653832;6590.044443555657;6592.571482853695;6593.241777195684;3775.4714339992424;3801.847926082981;3803.4294855771304;3806.638369354907;3812.504374431306;7174.067371241809;7184.6048467334795;7190.525942181945;7195.712171513081;7196.784096477114;6972.1284839395075;7098.964505177441;7126.821829454305;7128.607926564089;7153.749618763319;7155.67799449026;7160.677769500385;7172.928270717331;7183.676734546958;7190.3888169505135;6929.93070069313;6952.304769523007;6959.756408525677;6964.059851919926;6997;6700.994850772423;6853.211880633591;6861.725530978904;6869.072675188786;6907;7076.858462830817;7143.071400717873;7175.390091842252;7176.174739904978;7181.82045448847;4758.571728544448;4759.095771803346;4761.381020467317;4762.976185119052;4765.475797662324;6854.34883686049;6943.618101004493;6961.686724097529;6968.128983877015;6968.616726079911;6752.966235168793;6769.424598908951;6774.559653622498;6778;6780.898286525608;6692.531522793358;6713.12729345182;6756.256811750605;6760.357766012221;6767.89848152288;6463.3213512580505;6605.966970165118;6618.404343609098;6618.867622647616;6638.535302528777;6783.219929708147;6784.016317634014;6790.287019862843;6790.422814060663;6796.116504854337;6557.770478033246;6619.172603424572;6627;6627.204735431779;6657.234418041793 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: |5;yui.html;863.2101627011281;873.1268731268727;890.8129292848502;938.5025936253784;940.58144125864;14862.108273503583;15012.849871501281;15093.39626414942;15140.015898966572;15174.165420901874;14287.857121428782;14306.642333941656;14388.280585970711;14396.712065758678;14413.927930360334;741.9295166959157;746.8655641984454;877.0878286581947;891.17121077398;892.335210268351;880.3573391424264;892.8883889513811;894.6376717429418;897.5781382750097;902.2331018634142;934.392644780891;948.7011591348703;948.7722946492827;948.871902293192;950.6625148072438;930.6324002019198;936.2229349639816;936.4147407870081;937.8921424036255;939.6241503398661;690.6443181761397;692.2039654397433;693.5318659904594;694.2606124477466;698.6995591895483;14428.85571144296;14592.416303347853;14594.562163135122;14610.70778584433;14617.342219600143;13335.399907004208;13485.123466974615;13593.184408935496;13759.862401376058;13906.721865562633;11190.160737944687;11221.887781122166;11326.71683207918;11442.656720298404;11499.655010349703;3870.3420418528917;3896.649301562873;3932.488776459071;3951.9012024699323;3954.2684603348184;50098.24263180276;52225.216621750704;52531.999999999614;52619.210711839354;52889.20666189972;10449.318707216373;10473.266871318934;10894.509747061402;10909.509072091774;10958.671239862817;18153.7276940846;18236.179371928294;18312;18408.81591184071;19060.428187154408;8440.704575339834;8561.871571926426;8631;8660.047394786568;8710.085441028728;4820.228763397839;4834.347363106006;4857.8299759508245;4870.82952096682;4954.554090131834;3278.1476816028003;3302.1909632140278;3303.306305675835;3312.6521715220038;3320.053784671357;560.1597603594608;573.6386076771607;577.3648986115239;586.0125688215371;587.5886879184588;680.7481231944113;708.7483943200193;727.9844616759591;742;749.7076140305285;9174;9670.83630630144;9708.631115997829;9728.95135524332;9743.61025558984;551.6386766667839;590.4567797626195;592.4786188154396;652.1294072413381;669.1501792723311;4168.187203495289;4301.612854843079;4713.552212539803;4715.363425937455;4753.738544380023;61534;62244.68877655583;62582.37417625856;63301;63630;53315;53535.46464535305;54336.45663543393;54481.1827822583;55017;50006.49993500018;50096.74951625219;50126.498735012916;50343.49656503388;50500;9349.345545812;9463.905360946303;9555;9639;9660.95169524148;36105.45841812322;36743.81628091842;36908.63091369052;37422.25155496929;37443.43834842425;44822.77588612036;45677.77161114306;48839.75580122077;48955.02089958252;49914.75042624909;11571.710707232387;12171.634850954486;12175.45210465549;12194.817077743663;12238.143329966817;12697.619071427873;13466.66333341635;13700.24648644334;14104.435822566982;14164.858351416355;12032;12197.634070977885;12238.510459581517;12325.815112773495;12429.378531073591;12033.4584943676;12327.198732082386;12383.690407739517;12444.626661200178;12457.12800103984;12307.938460307641;12316.876831231573;12889.419976101286;12980.480780768663;13288.136271142344;10508.632197873038;10636.627718029831;11178.217524773188;11292.717682058013;11309.758840434837;10399.135066190223;10600.310979786289;10700.357978521313;10795.514201860778;10825.56697732082 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,311 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: __startTimestamp1453398496870__endTimestamp 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5528.65 Median:5756.11 stddev:615.27 (10.7%) stddev-sans-first:592.93 09:48:16 INFO - 2016-01-21 09:48:16,879 DEBUG : BROWSER_OUTPUT: Values: 3349.6 3362.9 3365.6 3392.6 3400.1 5529.8 5531.6 5536.9 5544.2 5550.6 5493.5 5533.6 5545.3 5546.9 5563.9 5040.3 5041.7 5131.4 5146.8 5182.5 4901.9 4974.0 5021.8 5022.6 5040.7 4987.2 5036.1 5039.1 5068.4 5101.2 5129.1 5150.5 5171.2 5175.7 5185.7 4782.0 4825.0 4875.3 5048.8 5057.6 5200.8 5230.4 5262.7 5264.9 5267.6 5890.5 5922.9 5987.8 5989.3 6003.5 5985.9 5988.3 6018.5 6042.6 6050.2 5334.4 5411.4 5460.3 5545.4 5584.3 6004.1 6031.8 6076.8 6097.8 6105.1 5647.4 5844.2 5868.6 5868.8 5876.0 5752.0 5777.5 5780.5 5819.6 5921.2 5894.0 5923.0 5928.0 5944.9 5950.5 5674.5 5797.8 5898.6 5948.5 5951.4 4527.1 4531.3 4533.6 4609.4 4668.0 4109.2 4113.4 4126.2 4129.9 4162.3 5520.4 5741.7 5758.6 5766.7 5788.1 5753.4 5977.7 6082.7 6087.7 6107.6 5641.8 5645.6 5674.2 5675.4 5682.6 5002.8 5104.4 5121.9 5151.7 5161.7 6107.5 6189.4 6191.0 6196.1 6223.3 6013.2 6017.0 6019.8 6023.1 6054.8 6034.1 6074.1 6103.5 6113.0 6154.0 5970.9 5973.0 5981.8 5990.4 5999.0 6009.8 6033.5 6038.6 6055.7 6066.3 5637.2 5698.3 5821.1 5908.3 5975.4 5906.3 5924.3 5931.5 5940.2 5942.8 5820.7 5846.2 5853.4 5854.8 5859.8 5647.0 5669.2 5695.6 5785.8 5796.6 5739.6 5756.1 5792.7 5803.2 5824.1 09:48:16 INFO - 2016-01-21 09:48:16,880 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,880 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58429.52 Median:22571.85 stddev:115381.34 (511.2%) stddev-sans-first:115623.25 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: Values: 574.5 606.1 607.5 638.2 643.8 38441.4 38944.4 38947.0 38950.0 38977.0 44851.0 45803.1 45854.3 46115.5 46119.8 9014.2 9202.2 9231.6 9238.4 9247.3 8893.8 8950.3 8966.6 8976.6 9004.3 9042.4 9097.0 9114.9 9137.2 9178.1 8926.4 9049.9 9104.5 9134.2 9134.5 8941.4 9005.2 9009.2 9021.8 9049.1 43600.0 44192.1 44281.0 44294.1 44353.3 3766.9 3816.5 3841.9 3853.4 4247.0 36771.0 36969.6 37203.4 37241.6 37242.4 3964.6 4035.5 4039.3 4102.9 4119.1 313420.0 314989.0 315590.0 316597.0 318056.4 45175.3 46042.3 46092.3 68675.0 68981.0 43377.6 43516.6 43643.0 43808.6 43845.6 17020.7 17082.6 17252.3 17266.0 17278.4 13682.4 13822.6 13824.6 13830.9 13839.7 15608.6 15617.3 15634.5 15748.6 15753.3 6028.7 6035.2 6078.6 6152.4 6247.2 998.2 1009.8 1015.4 1070.3 1086.7 30052.0 34633.1 34876.8 35024.3 35305.8 1120.1 1127.2 1140.4 1156.5 1179.4 15183.7 15265.3 15337.5 17465.6 18419.7 514119.0 540279.0 540285.0 661296.0 678661.0 61360.0 61986.4 62160.7 62292.4 62360.4 1428.3 1438.1 1464.4 1537.6 1610.6 30937.5 32128.4 32821.8 34172.3 34526.5 55052.0 55135.4 55357.7 55695.2 55717.7 335614.0 340308.0 341047.0 342074.0 344490.0 45705.8 46331.5 47193.5 47495.3 48347.3 46714.5 47127.8 47414.3 47792.8 48304.3 39219.2 40068.8 40691.4 40950.4 41040.8 43172.4 44869.8 45639.3 47500.5 48195.3 39732.8 39908.4 40006.6 40198.6 40301.4 34673.3 34702.8 34839.8 38530.0 40104.8 27054.3 27268.9 27276.5 27334.6 27486.6 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31036.95 Median:11069.75 stddev:96393.33 (870.8%) stddev-sans-first:96636.26 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: Values: 384.8 385.4 385.8 388.2 389.6 16209.4 17369.6 17446.5 20011.4 20128.7 12377.4 12417.6 12429.3 17137.4 17550.2 4758.4 5150.9 5215.3 5277.4 5675.2 4713.6 5143.9 5223.4 5269.1 5278.8 5178.6 5216.9 5230.4 5233.2 5579.6 5610.2 5611.1 5619.7 5636.7 5647.7 5204.7 5375.1 5376.2 5401.1 5445.0 13447.7 13647.2 13700.4 16857.7 21541.8 2266.4 2285.9 2342.4 2374.4 2375.7 10051.6 10101.5 10367.1 10397.7 10554.7 1994.0 2010.8 2025.6 2032.3 2052.1 66558.0 66568.3 67388.3 68467.7 69764.7 11023.2 11156.9 11208.0 11226.0 11232.0 14786.9 14854.9 14937.8 14945.0 14967.0 8210.3 8420.7 8704.3 8714.4 8724.5 8595.3 8647.2 8648.4 8662.1 8672.4 4685.3 4757.3 4782.1 4796.2 4828.6 1910.6 1910.7 1933.3 1935.5 1963.4 905.3 963.7 973.4 977.3 1000.0 15437.5 16469.7 17746.5 18212.8 18619.1 998.7 1011.3 1025.8 1040.2 1058.3 10281.5 10397.0 10420.1 10420.9 10477.7 574353.0 576850.0 592769.0 600018.0 602857.0 84785.0 85439.0 85582.7 87862.0 88228.0 1120.3 1134.1 1143.1 1144.6 1148.8 16172.5 16219.0 16532.2 16583.5 16692.2 37749.0 37904.0 37980.6 38026.6 38471.6 50477.7 50909.7 51090.2 51991.0 53166.2 10524.1 10605.4 10653.0 10726.6 10744.6 11908.0 17261.8 17973.6 18166.8 18547.5 15625.8 16042.2 16123.2 16239.4 16370.9 14525.8 14942.8 15214.7 15260.4 15634.1 15330.3 15444.0 15543.6 15875.5 16087.5 9716.3 9719.2 9845.3 10071.0 10123.1 10256.6 10267.1 12159.8 15367.6 15818.8 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5466.04 Median:6413.78 stddev:2797.97 (43.6%) stddev-sans-first:2789.84 09:48:16 INFO - 2016-01-21 09:48:16,881 DEBUG : BROWSER_OUTPUT: Values: 1487.0 1542.9 1623.4 1718.0 1842.4 7785.8 7807.3 7894.7 7967.9 7974.6 7997.2 8016.0 8043.8 8074.5 8103.4 2189.6 2220.5 2228.9 2231.8 2233.0 2327.9 2367.4 2369.0 2369.1 2369.3 2283.2 2318.4 2327.0 2337.5 2366.4 2314.5 2342.2 2350.7 2350.9 2359.1 2345.2 2367.7 2387.1 2389.7 2402.1 7856.5 7864.5 7937.5 7937.6 7939.9 4768.1 4811.0 4829.5 4843.5 4853.8 3059.6 3116.6 3118.6 3127.3 3140.1 951.7 965.1 975.6 981.6 1008.0 10425.2 10503.1 10513.4 10535.3 10552.6 4228.7 4247.0 4260.3 4272.4 4313.0 8748.4 8753.4 8763.3 8771.8 8782.2 4782.2 4787.7 4803.9 4821.9 4821.9 4359.2 4369.3 4373.0 4396.5 4414.1 3525.5 3571.1 3578.7 3596.8 3607.2 1076.9 1089.9 1097.2 1100.5 1108.2 980.8 1015.8 1035.5 1107.4 1225.3 7044.4 7048.8 7061.9 7067.5 7115.1 1104.5 1135.1 1144.4 1150.3 1161.2 5564.4 5567.9 5590.6 5613.9 5619.0 8795.6 9317.3 9368.0 9479.5 9522.6 9185.1 9209.2 9282.6 9353.3 9379.9 7137.1 7395.7 7407.9 7440.8 7466.0 7108.1 7124.5 7134.8 7151.5 7170.8 8063.6 8109.6 8322.8 8417.5 8435.2 8222.6 8370.9 8439.5 8447.7 8455.5 7080.1 7126.3 7165.4 7192.2 7216.5 7619.6 7638.0 7646.7 7656.7 7692.8 6744.6 6961.7 6976.2 7123.2 7128.4 6815.8 7009.6 7060.4 7069.5 7187.3 7076.7 7101.9 7107.9 7127.9 7145.5 6313.9 6346.4 6364.5 6366.9 6400.4 6378.7 6427.2 6490.3 6493.9 6500.2 09:48:16 INFO - 2016-01-21 09:48:16,882 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,882 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5628.73 Median:6526.59 stddev:1706.02 (26.1%) stddev-sans-first:1664.24 09:48:16 INFO - 2016-01-21 09:48:16,883 DEBUG : BROWSER_OUTPUT: Values: 354.1 354.2 358.6 358.8 361.8 6408.7 6423.4 6447.8 6454.4 6588.0 6352.0 6389.4 6400.6 6408.5 6424.6 4808.8 4829.6 4831.3 4838.9 4841.3 4834.4 4840.4 4850.9 4855.6 4856.9 4650.0 4775.0 4776.0 4776.7 4795.4 4738.6 4753.9 4757.1 4765.2 4774.1 4154.7 4167.6 4169.0 4171.2 4177.2 6017.7 6018.8 6024.8 6030.0 6035.2 5508.0 5577.8 5582.3 5583.3 5587.4 6624.2 6684.8 6696.2 6699.4 6704.0 4617.5 4621.3 4621.3 4622.2 4639.0 6869.4 6937.9 6969.9 7025.6 7039.4 4700.5 4707.3 4709.1 4709.2 4710.5 4775.8 4788.9 4792.7 4795.5 4808.5 5577.1 5579.9 5583.1 5593.0 5594.5 6722.7 6760.7 6769.3 6784.5 6797.0 1662.6 1686.5 1707.8 1708.7 1716.3 1119.2 1134.2 1140.9 1143.3 1152.3 6574.4 6579.8 6592.3 6596.9 6605.0 6877.1 6936.2 6952.9 6958.9 6964.5 6514.3 6538.9 6590.0 6592.6 6593.2 3775.5 3801.8 3803.4 3806.6 3812.5 7174.1 7184.6 7190.5 7195.7 7196.8 6972.1 7099.0 7126.8 7128.6 7153.7 7155.7 7160.7 7172.9 7183.7 7190.4 6929.9 6952.3 6959.8 6964.1 6997.0 6701.0 6853.2 6861.7 6869.1 6907.0 7076.9 7143.1 7175.4 7176.2 7181.8 4758.6 4759.1 4761.4 4763.0 4765.5 6854.3 6943.6 6961.7 6968.1 6968.6 6753.0 6769.4 6774.6 6778.0 6780.9 6692.5 6713.1 6756.3 6760.4 6767.9 6463.3 6606.0 6618.4 6618.9 6638.5 6783.2 6784.0 6790.3 6790.4 6796.1 6557.8 6619.2 6627.0 6627.2 6657.2 09:48:16 INFO - 2016-01-21 09:48:16,883 DEBUG : BROWSER_OUTPUT: 09:48:16 INFO - 2016-01-21 09:48:16,883 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14941.86 Median:4734.55 stddev:17102.35 (361.2%) stddev-sans-first:17117.65 09:48:16 INFO - 2016-01-21 09:48:16,884 DEBUG : BROWSER_OUTPUT: Values: 863.2 873.1 890.8 938.5 940.6 14862.1 15012.8 15093.4 15140.0 15174.2 14287.9 14306.6 14388.3 14396.7 14413.9 741.9 746.9 877.1 891.2 892.3 880.4 892.9 894.6 897.6 902.2 934.4 948.7 948.8 948.9 950.7 930.6 936.2 936.4 937.9 939.6 690.6 692.2 693.5 694.3 698.7 14428.9 14592.4 14594.6 14610.7 14617.3 13335.4 13485.1 13593.2 13759.9 13906.7 11190.2 11221.9 11326.7 11442.7 11499.7 3870.3 3896.6 3932.5 3951.9 3954.3 50098.2 52225.2 52532.0 52619.2 52889.2 10449.3 10473.3 10894.5 10909.5 10958.7 18153.7 18236.2 18312.0 18408.8 19060.4 8440.7 8561.9 8631.0 8660.0 8710.1 4820.2 4834.3 4857.8 4870.8 4954.6 3278.1 3302.2 3303.3 3312.7 3320.1 560.2 573.6 577.4 586.0 587.6 680.7 708.7 728.0 742.0 749.7 9174.0 9670.8 9708.6 9729.0 9743.6 551.6 590.5 592.5 652.1 669.2 4168.2 4301.6 4713.6 4715.4 4753.7 61534.0 62244.7 62582.4 63301.0 63630.0 53315.0 53535.5 54336.5 54481.2 55017.0 50006.5 50096.7 50126.5 50343.5 50500.0 9349.3 9463.9 9555.0 9639.0 9661.0 36105.5 36743.8 36908.6 37422.3 37443.4 44822.8 45677.8 48839.8 48955.0 49914.8 11571.7 12171.6 12175.5 12194.8 12238.1 12697.6 13466.7 13700.2 14104.4 14164.9 12032.0 12197.6 12238.5 12325.8 12429.4 12033.5 12327.2 12383.7 12444.6 12457.1 12307.9 12316.9 12889.4 12980.5 13288.1 10508.6 10636.6 11178.2 11292.7 11309.8 10399.1 10600.3 10700.4 10795.5 10825.6 09:48:16 INFO - 2016-01-21 09:48:16,884 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:48:16 INFO - 2016-01-21 09:48:16,884 DEBUG : BROWSER_OUTPUT: 09:48:17 INFO - 2016-01-21 09:48:17,578 INFO : Browser exited with error code: 0 09:48:17 INFO - 2016-01-21 09:48:17,594 INFO : Completed test dromaeo_css (00:18:29) 09:48:17 INFO - 2016-01-21 09:48:17,594 INFO : Starting test kraken 09:48:17 INFO - 2016-01-21 09:48:17,594 DEBUG : operating with platform_type : linux_ 09:48:17 INFO - 2016-01-21 09:48:17,594 INFO : Initialising browser for kraken test... 09:48:17 INFO - 2016-01-21 09:48:17,600 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpggTY9Z/profile http://localhost:41806/getInfo.html 09:48:21 INFO - 2016-01-21 09:48:21,464 DEBUG : BROWSER_OUTPUT: 09:48:21 INFO - 2016-01-21 09:48:21,464 DEBUG : BROWSER_OUTPUT: (process:23384): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:48:22 INFO - 2016-01-21 09:48:22,360 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:48:22 INFO - 2016-01-21 09:48:22,360 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:48:22 INFO - 2016-01-21 09:48:22,360 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:48:22 INFO - 2016-01-21 09:48:22,360 DEBUG : BROWSER_OUTPUT: __metrics 09:48:23 INFO - 2016-01-21 09:48:23,385 INFO : Browser initialized. 09:48:23 INFO - 2016-01-21 09:48:23,386 INFO : Running cycle 1/1 for kraken test... 09:48:23 INFO - 2016-01-21 09:48:23,386 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpggTY9Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:48:24 INFO - 2016-01-21 09:48:24,731 DEBUG : BROWSER_OUTPUT: 09:48:24 INFO - 2016-01-21 09:48:24,731 DEBUG : BROWSER_OUTPUT: (process:23500): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:48:35 INFO - 2016-01-21 09:48:35,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 136683520 09:48:35 INFO - 2016-01-21 09:48:35,235 DEBUG : BROWSER_OUTPUT: 09:48:37 INFO - 2016-01-21 09:48:37,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41806/tests/kraken/driver.html?testName=audio-beat-detection) 09:48:38 INFO - 2016-01-21 09:48:38,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 138944512 09:48:38 INFO - 2016-01-21 09:48:38,320 DEBUG : BROWSER_OUTPUT: 09:48:40 INFO - 2016-01-21 09:48:40,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41806/tests/kraken/driver.html?testName=audio-dft) 09:48:41 INFO - 2016-01-21 09:48:41,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 137474048 09:48:41 INFO - 2016-01-21 09:48:41,517 DEBUG : BROWSER_OUTPUT: 09:48:44 INFO - 2016-01-21 09:48:44,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41806/tests/kraken/driver.html?testName=audio-fft) 09:48:44 INFO - 2016-01-21 09:48:44,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 138194944 09:48:44 INFO - 2016-01-21 09:48:44,910 DEBUG : BROWSER_OUTPUT: 09:48:46 INFO - 2016-01-21 09:48:46,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41806/tests/kraken/driver.html?testName=audio-oscillator) 09:48:47 INFO - 2016-01-21 09:48:47,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 139161600 09:48:47 INFO - 2016-01-21 09:48:47,530 DEBUG : BROWSER_OUTPUT: 09:48:49 INFO - 2016-01-21 09:48:49,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41806/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:48:50 INFO - 2016-01-21 09:48:50,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 138129408 09:48:50 INFO - 2016-01-21 09:48:50,271 DEBUG : BROWSER_OUTPUT: 09:48:53 INFO - 2016-01-21 09:48:53,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41806/tests/kraken/driver.html?testName=imaging-darkroom) 09:48:53 INFO - 2016-01-21 09:48:53,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 137830400 09:48:53 INFO - 2016-01-21 09:48:53,811 DEBUG : BROWSER_OUTPUT: 09:48:57 INFO - 2016-01-21 09:48:57,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41806/tests/kraken/driver.html?testName=imaging-desaturate) 09:48:57 INFO - 2016-01-21 09:48:57,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 138067968 09:48:57 INFO - 2016-01-21 09:48:57,783 DEBUG : BROWSER_OUTPUT: 09:49:00 INFO - 2016-01-21 09:49:00,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41806/tests/kraken/driver.html?testName=json-parse-financial) 09:49:01 INFO - 2016-01-21 09:49:01,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 137883648 09:49:01 INFO - 2016-01-21 09:49:01,195 DEBUG : BROWSER_OUTPUT: 09:49:02 INFO - 2016-01-21 09:49:02,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41806/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:03 INFO - 2016-01-21 09:49:03,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 138735616 09:49:03 INFO - 2016-01-21 09:49:03,351 DEBUG : BROWSER_OUTPUT: 09:49:05 INFO - 2016-01-21 09:49:05,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:05 INFO - 2016-01-21 09:49:05,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 09:49:05 INFO - 2016-01-21 09:49:05,733 DEBUG : BROWSER_OUTPUT: 09:49:07 INFO - 2016-01-21 09:49:07,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:08 INFO - 2016-01-21 09:49:08,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 139210752 09:49:08 INFO - 2016-01-21 09:49:08,365 DEBUG : BROWSER_OUTPUT: 09:49:10 INFO - 2016-01-21 09:49:10,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:11 INFO - 2016-01-21 09:49:11,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 138584064 09:49:11 INFO - 2016-01-21 09:49:11,390 DEBUG : BROWSER_OUTPUT: 09:49:13 INFO - 2016-01-21 09:49:13,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:14 INFO - 2016-01-21 09:49:14,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 139714560 09:49:14 INFO - 2016-01-21 09:49:14,498 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41806/tests/kraken/driver.html?testName=ai-astar) 09:49:16 INFO - 2016-01-21 09:49:16,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 09:49:16 INFO - 2016-01-21 09:49:16,413 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,416 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:49:16 INFO - 2016-01-21 09:49:16,416 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:49:16 INFO - 2016-01-21 09:49:16,416 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:49:16 INFO - 2016-01-21 09:49:16,416 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;103;110;111;111;121;111;110;110;110 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;123;147;157;124;148;151;125;156;130 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;163;162;164;162;162;165;163;162 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;71;71;153;72;73;71;72;164;72 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;138;93;93;93;137;93;93;131 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;111;110;110;109;109 09:49:16 INFO - 2016-01-21 09:49:16,417 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;146;147;147;147;148;148;148;147 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;95;99;96;95;95 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;62;65;64;61;61;61;62;61 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;65;63;63;63;67;64;64;65 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;80;82;80;81;90;82;91;84;81 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;124;116;125;126;122;130;115;124;121 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;145;149;147;144;144;146;143;145;143 09:49:16 INFO - 2016-01-21 09:49:16,418 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;66;65;77;66;70;65;65;72 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1453398556414__endTimestamp 09:49:16 INFO - 2016-01-21 09:49:16,419 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: Values: 112.0 103.0 110.0 111.0 111.0 121.0 111.0 110.0 110.0 110.0 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.60 Median:149.50 stddev:14.33 (9.6%) stddev-sans-first:14.36 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: Values: 155.0 123.0 147.0 157.0 124.0 148.0 151.0 125.0 156.0 130.0 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 163.0 162.0 164.0 162.0 162.0 165.0 163.0 162.0 09:49:16 INFO - 2016-01-21 09:49:16,423 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.70 Median:72.00 stddev:36.41 (50.6%) stddev-sans-first:38.37 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: Values: 78.0 71.0 71.0 153.0 72.0 73.0 71.0 72.0 164.0 72.0 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:93.00 stddev:20.74 (22.3%) stddev-sans-first:21.34 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 138.0 93.0 93.0 93.0 137.0 93.0 93.0 131.0 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 111.0 110.0 110.0 109.0 109.0 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 09:49:16 INFO - 2016-01-21 09:49:16,424 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 146.0 147.0 147.0 147.0 148.0 148.0 148.0 147.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 95.0 99.0 96.0 95.0 95.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:1.66 (2.7%) stddev-sans-first:1.58 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 62.0 65.0 64.0 61.0 61.0 61.0 62.0 61.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 65.0 63.0 63.0 63.0 67.0 64.0 64.0 65.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:4.20 (5.1%) stddev-sans-first:4.19 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: Values: 88.0 80.0 82.0 80.0 81.0 90.0 82.0 91.0 84.0 81.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.00 stddev:4.81 (3.9%) stddev-sans-first:4.75 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: Values: 117.0 124.0 116.0 125.0 126.0 122.0 130.0 115.0 124.0 121.0 09:49:16 INFO - 2016-01-21 09:49:16,425 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:145.00 stddev:1.85 (1.3%) stddev-sans-first:1.96 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 149.0 147.0 144.0 144.0 146.0 143.0 145.0 143.0 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:66.50 stddev:3.96 (5.9%) stddev-sans-first:4.18 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 66.0 65.0 77.0 66.0 70.0 65.0 65.0 72.0 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:49:16 INFO - 2016-01-21 09:49:16,426 DEBUG : BROWSER_OUTPUT: 09:49:17 INFO - 2016-01-21 09:49:17,614 INFO : Browser exited with error code: 0 09:49:17 INFO - 2016-01-21 09:49:17,662 INFO : Completed test kraken (00:01:00) 09:49:17 INFO - 2016-01-21 09:49:17,662 INFO : Starting test v8_7 09:49:17 INFO - 2016-01-21 09:49:17,662 DEBUG : operating with platform_type : linux_ 09:49:17 INFO - 2016-01-21 09:49:17,662 INFO : Initialising browser for v8_7 test... 09:49:17 INFO - 2016-01-21 09:49:17,669 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1uZxat/profile http://localhost:41806/getInfo.html 09:49:21 INFO - 2016-01-21 09:49:21,613 DEBUG : BROWSER_OUTPUT: 09:49:21 INFO - 2016-01-21 09:49:21,613 DEBUG : BROWSER_OUTPUT: (process:23808): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:49:22 INFO - 2016-01-21 09:49:22,563 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:49:22 INFO - 2016-01-21 09:49:22,563 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:49:22 INFO - 2016-01-21 09:49:22,564 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:49:22 INFO - 2016-01-21 09:49:22,564 DEBUG : BROWSER_OUTPUT: __metrics 09:49:23 INFO - 2016-01-21 09:49:23,553 INFO : Browser initialized. 09:49:23 INFO - 2016-01-21 09:49:23,554 INFO : Running cycle 1/1 for v8_7 test... 09:49:23 INFO - 2016-01-21 09:49:23,554 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1uZxat/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:49:24 INFO - 2016-01-21 09:49:24,844 DEBUG : BROWSER_OUTPUT: 09:49:24 INFO - 2016-01-21 09:49:24,845 DEBUG : BROWSER_OUTPUT: (process:23920): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:49:35 INFO - 2016-01-21 09:49:35,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 135876608 09:49:35 INFO - 2016-01-21 09:49:35,352 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41806/tests/v8_7/run.html (next: http://localhost:41806/tests/v8_7/run.html) 09:49:56 INFO - 2016-01-21 09:49:56,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 136175616 09:49:56 INFO - 2016-01-21 09:49:56,966 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,967 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:49:56 INFO - 2016-01-21 09:49:56,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:49:56 INFO - 2016-01-21 09:49:56,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:49:56 INFO - 2016-01-21 09:49:56,967 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:49:56 INFO - 2016-01-21 09:49:56,968 DEBUG : BROWSER_OUTPUT: |0;Richards;164.79894528675015 09:49:56 INFO - 2016-01-21 09:49:56,968 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;171.96904557179707 09:49:56 INFO - 2016-01-21 09:49:56,968 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 09:49:56 INFO - 2016-01-21 09:49:56,969 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 09:49:56 INFO - 2016-01-21 09:49:56,969 DEBUG : BROWSER_OUTPUT: |4;RayTrace;923.3610341643582 09:49:56 INFO - 2016-01-21 09:49:56,969 DEBUG : BROWSER_OUTPUT: |5;Earley;548.5463521667581 09:49:56 INFO - 2016-01-21 09:49:56,969 DEBUG : BROWSER_OUTPUT: |6;Boyer;10967.391304347826 09:49:56 INFO - 2016-01-21 09:49:56,969 DEBUG : BROWSER_OUTPUT: |7;RegExp;24071.428571428572 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: |8;Splay;529.1005291005291 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: __startTimestamp1453398596964__endTimestamp 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:49:56 INFO - 2016-01-21 09:49:56,970 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: Values: 164.8 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:171.97 Median:171.97 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: Values: 172.0 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,971 DEBUG : BROWSER_OUTPUT: Values: 279.4 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: Values: 5143.6 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:923.36 Median:923.36 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,972 DEBUG : BROWSER_OUTPUT: Values: 923.4 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:548.55 Median:548.55 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: Values: 548.5 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10967.39 Median:10967.39 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: Values: 10967.4 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24071.43 Median:24071.43 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,973 DEBUG : BROWSER_OUTPUT: Values: 24071.4 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.10 Median:529.10 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: Values: 529.1 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:49:56 INFO - 2016-01-21 09:49:56,974 DEBUG : BROWSER_OUTPUT: 09:49:57 INFO - 2016-01-21 09:49:57,817 INFO : Browser exited with error code: 0 09:49:57 INFO - 2016-01-21 09:49:57,834 INFO : Completed test v8_7 (00:00:40) 09:49:58 INFO - 2016-01-21 09:49:58,009 INFO : Completed test suite (00:20:10) 09:49:58 INFO - 2016-01-21 09:49:58,010 DEBUG : Working with test: dromaeo_css 09:49:58 INFO - 2016-01-21 09:49:58,010 DEBUG : Generating results file: dromaeo_css 09:49:58 INFO - 2016-01-21 09:49:58,011 DEBUG : Working with test: kraken 09:49:58 INFO - 2016-01-21 09:49:58,011 DEBUG : Generating results file: kraken 09:49:58 INFO - 2016-01-21 09:49:58,011 INFO : javascript benchmark 09:49:58 INFO - 2016-01-21 09:49:58,011 DEBUG : Working with test: v8_7 09:49:58 INFO - 2016-01-21 09:49:58,012 DEBUG : Generating results file: v8_7 09:49:58 INFO - 2016-01-21 09:49:58,012 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:49:58 INFO - 2016-01-21 09:49:58,063 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:49:58 INFO - 2016-01-21 09:49:58,063 DEBUG : process_Request line: dromaeo_css 7383.57 graph.html#tests=[[72,52,43]] 09:49:58 INFO - 2016-01-21 09:49:58,063 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:49:58 INFO - 2016-01-21 09:49:58,096 DEBUG : process_Request line: kraken 1508.10 graph.html#tests=[[232,52,43]] 09:49:58 INFO - 2016-01-21 09:49:58,096 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:49:58 INFO - 2016-01-21 09:49:58,131 DEBUG : process_Request line: v8_7 23177.97 graph.html#tests=[[230,52,43]] 09:49:58 INFO - 2016-01-21 09:49:58,133 INFO : javascript benchmark 09:49:58 INFO - 2016-01-21 09:49:58,136 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3349.581302337208, 3362.8822991195298, 3365.5961284645846, 3392.643772403897, 3400.098973771951, 5529.806456774014, 5531.557475401958, 5536.916946245809, 5544.1960915667205, 5550.611457197998, 5493.533049690771, 5533.584981126422, 5545.306836645419, 5546.86132846678, 5563.944360556393, 5040.294358789773, 5041.6974981501135, 5131.435542090367, 5146.819861304855, 5182.481751824825, 4901.901961960759, 4974.0, 5021.799128034874, 5022.573081288095, 5040.672356296847, 4987.202047672373, 5036.11867923112, 5039.067772462106, 5068.366454193226, 5101.183810590306, 5129.102407078765, 5150.510701483353, 5171.172612382001, 5175.689458632494, 5185.688858668492, 4781.976090119562, 4825.0, 4875.268709693539, 5048.823291184827, 5057.595392368638, 5200.765965531522, 5230.372355317349, 5262.736863156865, 5264.947350526484, 5267.552258058031, 5890.528757699417, 5922.8815423691285, 5987.790427335066, 5989.251343582052, 6003.549733769984, 5985.940140598582, 5988.31134419543, 6018.548608854309, 6042.57701960863, 6050.183225264621, 5334.359876814807, 5411.404745477994, 5460.31746031746, 5545.362283337387, 5584.301962254718, 6004.0693692477735, 6031.788887388921, 6076.787312444043, 6097.847553811191, 6105.053716673922, 5647.350554686182, 5844.211031510777, 5868.618539794899, 5868.765249390062, 5875.970620146872, 5752.0, 5777.508911742465, 5780.479756821906, 5819.563532735062, 5921.171036054956, 5894.0274854648505, 5922.96348139074, 5927.962606543838, 5944.881102377928, 5950.464458198783, 5674.546036317085, 5797.826065218051, 5898.616589921641, 5948.494377977834, 5951.3751056139345, 4527.139843429738, 4531.297648864432, 4533.569310915458, 4609.446866375989, 4668.019715859639, 4109.157622687342, 4113.403556484293, 4126.195391898551, 4129.876103716893, 4162.313218319004, 5520.392756796749, 5741.712914354265, 5758.568107391962, 5766.740496677659, 5788.102844059177, 5753.367129615739, 5977.731002104916, 6082.695865206722, 6087.6956152192215, 6107.633541987495, 5641.830745077655, 5645.604807663506, 5674.177244299636, 5675.3757086720425, 5682.573806964494, 5002.799888004512, 5104.3874735031295, 5121.923171152435, 5151.665141765773, 5161.716105614228, 6107.450329470369, 6189.442950134509, 6191.0, 6196.10156527301, 6223.346548612421, 6013.188219590299, 6017.0, 6019.789307374221, 6023.126646636126, 6054.8183554493435, 6034.125051867367, 6074.119252708421, 6103.450689437972, 6112.989854784201, 6154.015357542772, 5970.880582388415, 5973.01445261527, 5981.820545383645, 5990.371011043778, 5999.0, 6009.759609615567, 6033.5173186145885, 6038.5772995889865, 6055.666938318434, 6066.272047354346, 5637.2107904894165, 5698.2592263005545, 5821.068629019336, 5908.291005079418, 5975.40245975399, 5906.291245050621, 5924.289085309618, 5931.525477961839, 5940.227770389822, 5942.762289508371, 5820.679862607597, 5846.210761547137, 5853.385394533512, 5854.824355269348, 5859.794907178229, 5646.971765141148, 5669.20631111653, 5695.572832037531, 5785.8139081489035, 5796.565257605781, 5739.598228123991, 5756.107803290497, 5792.652440853562, 5803.158542011469, 5824.097264923944], "unit": "ms", "name": "dojo.html", "value": 5489.148064331615}, {"lowerIsBetter": false, "replicates": [574.46861652971, 606.1453350775407, 607.489708644738, 638.2086213095761, 643.8004218692205, 38441.423378649306, 38944.41583376252, 38947.0, 38950.0, 38977.0, 44851.0, 45803.083938321215, 45854.31218531725, 46115.53884461155, 46119.769401152946, 9014.188723014911, 9202.217811486033, 9231.58457869394, 9238.445693258393, 9247.306452016126, 8893.77765555863, 8950.328725345593, 8966.641334346617, 8976.551172441385, 9004.324675649352, 9042.367034307601, 9096.954515227415, 9114.86327705085, 9137.223336016446, 9178.128077832629, 8926.37515373924, 9049.864252036225, 9104.453732776055, 9134.223590994774, 9134.497602631853, 8941.374103812735, 9005.189532942, 9009.189172974398, 9021.819563608757, 9049.140331668481, 43600.0, 44192.11615767699, 44281.0, 44294.114117717465, 44353.334699979525, 3766.9246615067545, 3816.46569480273, 3841.9231615367817, 3853.441251018615, 4246.957530424687, 36771.0, 36969.63030369689, 37203.4419483708, 37241.62758372409, 37242.44136337957, 3964.6088080326017, 4035.4955630546183, 4039.2931237033695, 4102.897427564305, 4119.134981653856, 313420.0, 314989.0, 315590.0, 316597.0, 318056.40971795225, 45175.322370164475, 46042.30936535955, 46092.3086153708, 68675.0, 68981.0, 43377.56622433735, 43516.564834351884, 43643.0, 43808.56191438108, 43845.561544384145, 17020.744688829676, 17082.57293567646, 17252.309907603805, 17266.0, 17278.395256166226, 13682.384292706853, 13822.585322440344, 13824.585262442142, 13830.930845345709, 13839.654008649864, 15608.609784755472, 15617.297221625055, 15634.53096407087, 15748.606284842741, 15753.291101900442, 6028.698565071729, 6035.245594300713, 6078.6048906820915, 6152.3540028297275, 6247.187865577536, 998.1864780204111, 1009.7627057641448, 1015.4262841494532, 1070.3256948122632, 1086.6848613902039, 30052.0, 34633.134171645914, 34876.825615871756, 35024.29951400957, 35305.82347088299, 1120.0871289898869, 1127.2222166704948, 1140.4367862948677, 1156.462245056053, 1179.4279774309452, 15183.696326073417, 15265.313060912285, 15337.539873803804, 17465.563360915825, 18419.72370414445, 514119.0, 540279.0, 540285.0, 661296.0, 678661.0, 61360.0, 61986.38013619896, 62160.68919655373, 62292.37707622956, 62360.37639623546, 1428.3429622373617, 1438.0868148725845, 1464.3922772049693, 1537.6463413414976, 1610.5973506623345, 30937.535936961413, 32128.35743285168, 32821.835890820395, 34172.31655366928, 34526.48210276798, 55052.0, 55135.44864551303, 55357.72321138369, 55695.16457253064, 55717.72141139268, 335614.0, 340308.0, 341047.0, 342074.0, 344490.0, 45705.77147114376, 46331.53668463407, 47193.528064718914, 47495.287570685774, 48347.27479087746, 46714.532854672376, 47127.76436117797, 47414.28878566755, 47792.76103619599, 48304.275435867785, 39219.21561568695, 40068.7996560027, 40691.389629155, 40950.385744213265, 41040.794796027025, 43172.352414714434, 44869.77565112284, 45639.31541026953, 47500.52499474961, 48195.277070843265, 39732.801335993136, 39908.401373978835, 40006.59993400029, 40198.59801401949, 40301.39547906725, 34673.30653386968, 34702.82648586741, 34839.825800870836, 38530.0, 40104.79947600243, 27054.323641908322, 27268.863655681595, 27276.454470910867, 27334.589981150697, 27486.587701184097], "unit": "ms", "name": "ext.html", "value": 20263.339065278768}, {"lowerIsBetter": false, "replicates": [384.8037500874555, 385.3814627522826, 385.77624977513045, 388.2177412513787, 389.5578518381638, 16209.351625934978, 17369.565760855952, 17446.476605701835, 20011.399658010247, 20128.69806952895, 12377.443015064344, 12417.56538521152, 12429.31638759868, 17137.400190993318, 17550.210240539174, 4758.405199350082, 5150.922736158961, 5215.295935048758, 5277.366715994086, 5675.2054712340305, 4713.646476514258, 5143.871403214912, 5223.399309079447, 5269.104252277103, 5278.762455689484, 5178.637495375326, 5216.921746173811, 5230.398504172012, 5233.188855727369, 5579.581531385163, 5610.158476228557, 5611.102223644218, 5619.690916999563, 5636.7463464144, 5647.689377084259, 5204.661696989721, 5375.11310633745, 5376.247325374451, 5401.135818269058, 5444.96545656324, 13447.731045379038, 13647.181169129784, 13700.3834827433, 16857.747133793004, 21541.78458215429, 2266.3994041578994, 2285.897134628946, 2342.4143964009, 2374.358923090756, 2375.67928329675, 10051.648192313234, 10101.49492525378, 10367.066963973202, 10397.688069357931, 10554.736131596695, 1993.990030049855, 2010.7989201079922, 2025.6252593270292, 2032.3293313206607, 2052.0868213644935, 66558.00162997608, 66568.33431665719, 67388.3261167387, 68467.65766171187, 69764.6511767443, 11023.17326200522, 11156.944215278872, 11208.0, 11226.045786108272, 11232.0, 14786.926065369604, 14854.925725371304, 14937.775933361008, 14945.02857314271, 14967.0, 8210.343172546181, 8420.705275315335, 8704.303655707528, 8714.433561818461, 8724.476531408009, 8595.269402100766, 8647.221750042527, 8648.351373647001, 8662.094339245356, 8672.436291641023, 4685.273782563708, 4757.333973243749, 4782.067496838084, 4796.208625576741, 4828.637852161102, 1910.6274276516224, 1910.6942889137672, 1933.3083551892094, 1935.4774210962962, 1963.3619073801071, 905.2667339455063, 963.6868017894212, 973.4402718436786, 977.296346630425, 999.985045089057, 15437.459688910834, 16469.68242540594, 17746.46760597184, 18212.817871821113, 18619.06904654789, 998.6904059741504, 1011.2567263061644, 1025.8102251083574, 1040.1782591752583, 1058.264506168221, 10281.485925703684, 10397.0, 10420.114290285259, 10420.947895260626, 10477.68566942993, 574353.0, 576850.0, 592769.0, 600018.0, 602857.0, 84785.0, 85439.0, 85582.71625925617, 87862.0, 88228.0, 1120.3278033180027, 1134.0813940708053, 1143.108375467137, 1144.5765066925292, 1148.7530181010954, 16172.514824555283, 16219.0, 16532.173391330627, 16583.50249492517, 16692.165391730607, 37749.0, 37904.0, 37980.620193798815, 38026.61973380342, 38471.615283846804, 50477.74761126171, 50909.745451273986, 51090.23364649459, 51991.0, 53166.2025069632, 10524.052835244558, 10605.363678179334, 10653.041226289672, 10726.624568140078, 10744.623938162127, 11908.0, 17261.827381726525, 17973.550661233574, 18166.818331816514, 18547.536311592317, 15625.76561351558, 16042.197890105215, 16123.193840307704, 16239.431619893247, 16370.918145409196, 14525.78211326852, 14942.775858361916, 15214.695706086037, 15260.389584416498, 15634.06195628266, 15330.310136044129, 15444.0, 15543.611409714847, 15875.52373428799, 16087.517374478784, 9716.3198576099, 9719.17387022111, 9845.261605379483, 10071.0, 10123.088921997056, 10256.58973641046, 10267.127294180078, 12159.81760273579, 15367.61580960485, 15818.841811581737], "unit": "ms", "name": "jquery.html", "value": 9299.555907506938}, {"lowerIsBetter": false, "replicates": [1486.95539133826, 1542.861142497175, 1623.3831144165215, 1717.957051073723, 1842.4012196036292, 7785.844283114335, 7807.297343239107, 7894.684212631488, 7967.88048179277, 7974.601269936509, 7997.200279972, 8016.038075430956, 8043.758687239378, 8074.51552906826, 8103.3922455815755, 2189.6058709432295, 2220.467087898901, 2228.9108435662556, 2231.8102961248233, 2233.039792889057, 2327.8952447139836, 2367.396313939943, 2369.0168580039262, 2369.123424332999, 2369.3365857559825, 2283.1666441748725, 2318.3972167236557, 2327.011020316367, 2337.497438050819, 2366.432056306491, 2314.467672435341, 2342.2153578551206, 2350.7296660884044, 2350.882455877208, 2359.091749676387, 2345.2495201535517, 2367.6803631509697, 2387.08097382509, 2389.7371289158177, 2402.1112188490197, 7856.528608283465, 7864.488808227504, 7937.484063535851, 7937.642806073741, 7939.880901786478, 4768.094062128184, 4811.0, 4829.541193586604, 4843.515648435164, 4853.781579828881, 3059.571659967606, 3116.6104236970377, 3118.6257649082027, 3127.3119913618966, 3140.120766185472, 951.728757304172, 965.0783501755807, 975.5658731864323, 981.6466072213997, 1007.9567647484818, 10425.218108641882, 10503.10723588496, 10513.421761803098, 10535.262531622866, 10552.630657926935, 4228.70399072062, 4246.957530424718, 4260.318349064135, 4272.380504826782, 4313.029568347097, 8748.387612867165, 8753.431026983226, 8763.298936085097, 8771.824563508693, 8782.165694259034, 4782.187028205144, 4787.736674482867, 4803.879903002453, 4821.879453013703, 4821.9035619287415, 4359.17175736609, 4369.344598310279, 4373.037931655031, 4396.450443694538, 4414.139242847678, 3525.524054252643, 3571.1072231942017, 3578.6958108561066, 3596.7662101963288, 3607.1703508193264, 1076.8976947190004, 1089.9481999870163, 1097.182598963777, 1100.4937728644752, 1108.1578000719512, 980.838161703311, 1015.7562185075528, 1035.5236591168148, 1107.429673718036, 1225.3383173086434, 7044.401225895856, 7048.823779405556, 7061.9293807062295, 7067.5052746307265, 7115.146182458138, 1104.5140138339266, 1135.0917681084768, 1144.3934714601276, 1150.3328069719544, 1161.1929708852267, 5564.443555644484, 5567.860803479945, 5590.608657393944, 5613.887722245532, 5619.016672082369, 8795.648174072965, 9317.254619630414, 9368.0, 9479.526023698787, 9522.619095236112, 9185.127412895765, 9209.171174594185, 9282.582283797245, 9353.251739860794, 9379.859302110473, 7137.1435427749, 7395.741149059757, 7407.925920740724, 7440.813979650444, 7465.962670186615, 7108.07595012645, 7124.536905101152, 7134.750283740044, 7151.463640227108, 7170.820729481805, 8063.596820158851, 8109.553974531457, 8322.750317490485, 8417.494950303002, 8435.24082832548, 8222.588870556328, 8370.87443688333, 8439.493630382196, 8447.704330348408, 8455.492670439793, 7080.079589653518, 7126.2873712628325, 7165.3551180394015, 7192.244814294424, 7216.530925489827, 7619.580923049064, 7637.961810190914, 7646.694132234648, 7656.655450504629, 7692.7692169235015, 6744.5616034957575, 6961.7215311389, 6976.232614412512, 7123.216446191019, 7128.429725622042, 6815.795526134224, 7009.614471204132, 7060.399866011447, 7069.505134640732, 7187.31720486553, 7076.681549330189, 7101.8579628406105, 7107.893381599383, 7127.893081603884, 7145.4998150128995, 6313.873722525432, 6346.397092276226, 6364.459020983269, 6366.9044964326495, 6400.359964003748, 6378.6810659467765, 6427.196600424947, 6490.3185165558825, 6493.8701225976165, 6500.219973603198], "unit": "ms", "name": "mootools.html", "value": 4496.157201545085}, {"lowerIsBetter": false, "replicates": [354.05114293692924, 354.18360678635753, 358.56255368450496, 358.7524608020466, 361.8498323195873, 6408.679566021698, 6423.3897779710915, 6447.838804029896, 6454.354564543543, 6588.0, 6351.968240158804, 6389.361063893608, 6400.647964361959, 6408.519361047916, 6424.5502814802985, 4808.807647694088, 4829.637777166709, 4831.251156070814, 4838.927416088762, 4841.3222148899185, 4834.371531700892, 4840.443349014873, 4850.878728031792, 4855.635827312948, 4856.902861942759, 4650.046740418206, 4775.021120670254, 4776.044791041805, 4776.68951518152, 4795.376601041877, 4738.6446016548725, 4753.928691069636, 4757.1437141314545, 4765.237561990082, 4774.116788394158, 4154.709170358076, 4167.5832416758385, 4169.0, 4171.228322760268, 4177.248095342837, 6017.669028203447, 6018.8194354169445, 6024.819255422344, 6029.969850150765, 6035.155078288999, 5508.0, 5577.776888924438, 5582.302212223472, 5583.274174357348, 5587.413321601254, 6624.238212605564, 6684.766033188815, 6696.1629796275465, 6699.363560461748, 6704.0, 4617.468991066037, 4621.30680397943, 4621.329907163443, 4622.237330840408, 4639.0, 6869.416099631538, 6937.861242775167, 6969.9303006969785, 7025.613591252479, 7039.436845052383, 4700.45944716362, 4707.29390591414, 4709.081729062868, 4709.152352576501, 4710.481846996828, 4775.761211939389, 4788.904221915543, 4792.688475249098, 4795.544423279783, 4808.543188397097, 5577.107662773937, 5579.888402231933, 5583.134614134816, 5593.049181639131, 5594.524465420403, 6722.66386680664, 6760.7295708172105, 6769.255381907986, 6784.457243420515, 6797.0, 1662.5760431089996, 1686.4856218853122, 1707.7694511241073, 1708.6924353616469, 1716.3392094043634, 1119.2221406122828, 1134.2003887259461, 1140.8573928258968, 1143.2683082826998, 1152.3374059915582, 6574.3754343337305, 6579.8026059217345, 6592.30780768022, 6596.901046484307, 6605.042268870987, 6877.105976223059, 6936.2023367312395, 6952.930470695228, 6958.930410695828, 6964.512484126062, 6514.250861151028, 6538.934610653832, 6590.044443555657, 6592.571482853695, 6593.241777195684, 3775.4714339992424, 3801.847926082981, 3803.4294855771304, 3806.638369354907, 3812.504374431306, 7174.067371241809, 7184.6048467334795, 7190.525942181945, 7195.712171513081, 7196.784096477114, 6972.1284839395075, 7098.964505177441, 7126.821829454305, 7128.607926564089, 7153.749618763319, 7155.67799449026, 7160.677769500385, 7172.928270717331, 7183.676734546958, 7190.3888169505135, 6929.93070069313, 6952.304769523007, 6959.756408525677, 6964.059851919926, 6997.0, 6700.994850772423, 6853.211880633591, 6861.725530978904, 6869.072675188786, 6907.0, 7076.858462830817, 7143.071400717873, 7175.390091842252, 7176.174739904978, 7181.82045448847, 4758.571728544448, 4759.095771803346, 4761.381020467317, 4762.976185119052, 4765.475797662324, 6854.34883686049, 6943.618101004493, 6961.686724097529, 6968.128983877015, 6968.616726079911, 6752.966235168793, 6769.424598908951, 6774.559653622498, 6778.0, 6780.898286525608, 6692.531522793358, 6713.12729345182, 6756.256811750605, 6760.357766012221, 6767.89848152288, 6463.3213512580505, 6605.966970165118, 6618.404343609098, 6618.867622647616, 6638.535302528777, 6783.219929708147, 6784.016317634014, 6790.287019862843, 6790.422814060663, 6796.116504854337, 6557.770478033246, 6619.172603424572, 6627.0, 6627.204735431779, 6657.234418041793], "unit": "ms", "name": "prototype.html", "value": 5073.776902974634}, {"lowerIsBetter": false, "replicates": [863.2101627011281, 873.1268731268727, 890.8129292848502, 938.5025936253784, 940.58144125864, 14862.108273503583, 15012.849871501281, 15093.39626414942, 15140.015898966572, 15174.165420901874, 14287.857121428782, 14306.642333941656, 14388.280585970711, 14396.712065758678, 14413.927930360334, 741.9295166959157, 746.8655641984454, 877.0878286581947, 891.17121077398, 892.335210268351, 880.3573391424264, 892.8883889513811, 894.6376717429418, 897.5781382750097, 902.2331018634142, 934.392644780891, 948.7011591348703, 948.7722946492827, 948.871902293192, 950.6625148072438, 930.6324002019198, 936.2229349639816, 936.4147407870081, 937.8921424036255, 939.6241503398661, 690.6443181761397, 692.2039654397433, 693.5318659904594, 694.2606124477466, 698.6995591895483, 14428.85571144296, 14592.416303347853, 14594.562163135122, 14610.70778584433, 14617.342219600143, 13335.399907004208, 13485.123466974615, 13593.184408935496, 13759.862401376058, 13906.721865562633, 11190.160737944687, 11221.887781122166, 11326.71683207918, 11442.656720298404, 11499.655010349703, 3870.3420418528917, 3896.649301562873, 3932.488776459071, 3951.9012024699323, 3954.2684603348184, 50098.24263180276, 52225.216621750704, 52531.999999999614, 52619.210711839354, 52889.20666189972, 10449.318707216373, 10473.266871318934, 10894.509747061402, 10909.509072091774, 10958.671239862817, 18153.7276940846, 18236.179371928294, 18312.0, 18408.81591184071, 19060.428187154408, 8440.704575339834, 8561.871571926426, 8631.0, 8660.047394786568, 8710.085441028728, 4820.228763397839, 4834.347363106006, 4857.8299759508245, 4870.82952096682, 4954.554090131834, 3278.1476816028003, 3302.1909632140278, 3303.306305675835, 3312.6521715220038, 3320.053784671357, 560.1597603594608, 573.6386076771607, 577.3648986115239, 586.0125688215371, 587.5886879184588, 680.7481231944113, 708.7483943200193, 727.9844616759591, 742.0, 749.7076140305285, 9174.0, 9670.83630630144, 9708.631115997829, 9728.95135524332, 9743.61025558984, 551.6386766667839, 590.4567797626195, 592.4786188154396, 652.1294072413381, 669.1501792723311, 4168.187203495289, 4301.612854843079, 4713.552212539803, 4715.363425937455, 4753.738544380023, 61534.0, 62244.68877655583, 62582.37417625856, 63301.0, 63630.0, 53315.0, 53535.46464535305, 54336.45663543393, 54481.1827822583, 55017.0, 50006.49993500018, 50096.74951625219, 50126.498735012916, 50343.49656503388, 50500.0, 9349.345545812, 9463.905360946303, 9555.0, 9639.0, 9660.95169524148, 36105.45841812322, 36743.81628091842, 36908.63091369052, 37422.25155496929, 37443.43834842425, 44822.77588612036, 45677.77161114306, 48839.75580122077, 48955.02089958252, 49914.75042624909, 11571.710707232387, 12171.634850954486, 12175.45210465549, 12194.817077743663, 12238.143329966817, 12697.619071427873, 13466.66333341635, 13700.24648644334, 14104.435822566982, 14164.858351416355, 12032.0, 12197.634070977885, 12238.510459581517, 12325.815112773495, 12429.378531073591, 12033.4584943676, 12327.198732082386, 12383.690407739517, 12444.626661200178, 12457.12800103984, 12307.938460307641, 12316.876831231573, 12889.419976101286, 12980.480780768663, 13288.136271142344, 10508.632197873038, 10636.627718029831, 11178.217524773188, 11292.717682058013, 11309.758840434837, 10399.135066190223, 10600.310979786289, 10700.357978521313, 10795.514201860778, 10825.56697732082], "unit": "ms", "name": "yui.html", "value": 6866.015612724155}], "name": "dromaeo_css", "value": 7383.562056329863}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 103.0, 110.0, 111.0, 111.0, 121.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [155.0, 123.0, 147.0, 157.0, 124.0, 148.0, 151.0, 125.0, 156.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 164.0, 162.0, 162.0, 165.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [78.0, 71.0, 71.0, 153.0, 72.0, 73.0, 71.0, 72.0, 164.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 138.0, 93.0, 93.0, 93.0, 137.0, 93.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 99.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [60.0, 64.0, 62.0, 65.0, 64.0, 61.0, 61.0, 61.0, 62.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 63.0, 63.0, 63.0, 67.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [88.0, 80.0, 82.0, 80.0, 81.0, 90.0, 82.0, 91.0, 84.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [117.0, 124.0, 116.0, 125.0, 126.0, 122.0, 130.0, 115.0, 124.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 149.0, 147.0, 144.0, 144.0, 146.0, 143.0, 145.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 65.0, 77.0, 66.0, 70.0, 65.0, 65.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1508.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.79894528675015], "unit": "score", "name": "Richards", "value": 214.21253599999997}, {"lowerIsBetter": false, "replicates": [171.96904557179707], "unit": "score", "name": "DeltaBlue", "value": 384.47617}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [923.3610341643582], "unit": "score", "name": "RayTrace", "value": 801.4080869999998}, {"lowerIsBetter": false, "replicates": [548.5463521667581], "unit": "score", "name": "Earley", "value": 1214.9620489999998}, {"lowerIsBetter": false, "replicates": [10967.391304347826], "unit": "score", "name": "Boyer", "value": 60.7676868186323}, {"lowerIsBetter": false, "replicates": [24071.428571428572], "unit": "score", "name": "RegExp", "value": 37.845074183976266}, {"lowerIsBetter": false, "replicates": [529.1005291005291], "unit": "score", "name": "Splay", "value": 154.01798999999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23177.969068123475}]} 09:49:58 INFO - RETURN: dromaeo_css: 7383.57 09:49:58 INFO - RETURN: kraken: 1508.10 09:49:58 INFO - RETURN: v8_7: 23177.97 09:49:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23177.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7383.57"}}} 09:49:58 INFO - Return code: 0 09:49:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:49:58 INFO - # TBPL SUCCESS # 09:49:58 INFO - Running post-action listener: _resource_record_post_action 09:49:58 INFO - Running post-run listener: _resource_record_post_run 09:49:59 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518139904; Read time: 1224; Write time: 1084680 09:49:59 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 4096; Write bytes: 238305280; Read time: 776; Write time: 816980 09:49:59 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275812352; Read time: 448; Write time: 266712 09:49:59 INFO - Running post-run listener: _upload_blobber_files 09:49:59 INFO - Blob upload gear active. 09:49:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:49:59 INFO - Copying logs to upload dir... 09:49:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.006717 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-21 09:49:58.920215) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:49:58.923952) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009965 build_url: 'https://queue.taskcluster.net/v1/task/tLa9pncVT8qGSu8AsFpoUQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-21 09:49:58.974118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:49:58.974420) ========= 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=af724c981e2a0f424dbabf99000001e7-1453397333.837052-217770704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 09:49:59.023331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:49:59.023658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 09:49:59.023933) ========= ========= Total master_lag: 0.27 =========