builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1450359879.46 results: success (0) buildid: 20151217030207 builduid: c3c8371340cb4376bfad6851a8223e5c revision: f143af51f6e35932927b8ccac2509facbbe7b539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.457085) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.457598) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.457953) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006444 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.481208) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.481532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.495111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.495520) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.549664) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.550048) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.550514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.550839) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 05:44:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.2M=0s 2015-12-17 05:44:40 (47.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168838 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.733554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.733865) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.784009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:39.784452) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f143af51f6e35932927b8ccac2509facbbe7b539 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f143af51f6e35932927b8ccac2509facbbe7b539 --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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 05:44:40,192 truncating revision to first 12 chars 2015-12-17 05:44:40,192 Setting DEBUG logging. 2015-12-17 05:44:40,192 attempt 1/10 2015-12-17 05:44:40,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f143af51f6e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 05:44:40,435 unpacking tar archive at: mozilla-central-f143af51f6e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510700 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:40.309335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:40.309640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:40.521074) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:40.521417) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 05:44:40.521851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2015-12-17 05:44:40.522156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:41 INFO - MultiFileLogger online at 20151217 05:44:41 in /builds/slave/test-pgo 05:44:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:44:41 INFO - {'append_to_log': False, 05:44:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:44:41 INFO - 'blob_upload_branch': 'Firefox', 05:44:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:44:41 INFO - 'branch': 'Firefox', 05:44:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:41 INFO - 'config_files': ('talos/linux_config.py',), 05:44:41 INFO - 'default_actions': ('clobber', 05:44:41 INFO - 'read-buildbot-config', 05:44:41 INFO - 'download-and-extract', 05:44:41 INFO - 'populate-webroot', 05:44:41 INFO - 'create-virtualenv', 05:44:41 INFO - 'install', 05:44:41 INFO - 'run-tests'), 05:44:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:41 INFO - 'download_minidump_stackwalk': True, 05:44:41 INFO - 'download_symbols': 'ondemand', 05:44:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:41 INFO - 'installer_path': 'installer.exe', 05:44:41 INFO - 'log_level': 'info', 05:44:41 INFO - 'log_name': 'talos', 05:44:41 INFO - 'log_to_console': True, 05:44:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:41 INFO - 'opt_config_files': (), 05:44:41 INFO - 'pip_index': False, 05:44:41 INFO - 'sps_profile': False, 05:44:41 INFO - 'sps_profile_interval': 0, 05:44:41 INFO - 'suite': 'dromaeojs-e10s', 05:44:41 INFO - 'system_bits': '64', 05:44:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:41 INFO - 'title': 'talos-linux64-ix-013', 05:44:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:41 INFO - 'use_talos_json': True, 05:44:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:44:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:41 INFO - 'work_dir': 'build'} 05:44:41 INFO - ##### 05:44:41 INFO - ##### Running clobber step. 05:44:41 INFO - ##### 05:44:41 INFO - Running pre-action listener: _resource_record_pre_action 05:44:41 INFO - Running main action method: clobber 05:44:41 INFO - rmtree: /builds/slave/test-pgo/build 05:44:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:44:41 INFO - Running post-action listener: _resource_record_post_action 05:44:41 INFO - ##### 05:44:41 INFO - ##### Running read-buildbot-config step. 05:44:41 INFO - ##### 05:44:41 INFO - Running pre-action listener: _resource_record_pre_action 05:44:41 INFO - Running main action method: read_buildbot_config 05:44:41 INFO - Using buildbot properties: 05:44:41 INFO - { 05:44:41 INFO - "project": "", 05:44:41 INFO - "product": "firefox", 05:44:41 INFO - "script_repo_revision": "production", 05:44:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:44:41 INFO - "repository": "", 05:44:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:44:41 INFO - "buildid": "20151217030207", 05:44:41 INFO - "stage_platform": "linux64-pgo", 05:44:41 INFO - "basedir": "/builds/slave/test-pgo", 05:44:41 INFO - "nightly_build": "True", 05:44:41 INFO - "buildnumber": 581, 05:44:41 INFO - "slavename": "talos-linux64-ix-013", 05:44:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:44:41 INFO - "platform": "ubuntu64_hw", 05:44:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:41 INFO - "branch": "mozilla-central", 05:44:41 INFO - "repo_path": "mozilla-central", 05:44:41 INFO - "revision": "f143af51f6e35932927b8ccac2509facbbe7b539", 05:44:41 INFO - "pgo_build": "True", 05:44:41 INFO - "builduid": "c3c8371340cb4376bfad6851a8223e5c", 05:44:41 INFO - "slavebuilddir": "test" 05:44:41 INFO - } 05:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:44:41 INFO - Running post-action listener: _resource_record_post_action 05:44:41 INFO - ##### 05:44:41 INFO - ##### Running download-and-extract step. 05:44:41 INFO - ##### 05:44:41 INFO - Running pre-action listener: _resource_record_pre_action 05:44:41 INFO - Running main action method: download_and_extract 05:44:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:44:41 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')]} 05:44:41 INFO - https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/test_packages.json 05:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/test_packages.json 05:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:44:42 INFO - Downloaded 1302 bytes. 05:44:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:44:42 INFO - Using the following test package requirements: 05:44:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'jsshell-linux-x86_64.zip'], 05:44:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:42 INFO - https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:47 INFO - Downloaded 23118124 bytes. 05:44:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:44:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:44:48 INFO - Return code: 0 05:44:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:48 INFO - https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:50 INFO - Downloaded 23118124 bytes. 05:44:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:44:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:44:53 INFO - Return code: 0 05:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:53 INFO - https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:44:54 INFO - Downloaded 11132052 bytes. 05:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:44:54 INFO - Return code: 0 05:44:54 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')]} 05:44:54 INFO - https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:44:56 INFO - Downloaded 59282471 bytes. 05:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:57 INFO - mkdir: /builds/slave/test-pgo/properties 05:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:44:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:44:57 INFO - Contents: 05:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:44:57 INFO - Running post-action listener: _resource_record_post_action 05:44:57 INFO - Running post-action listener: set_extra_try_arguments 05:44:57 INFO - ##### 05:44:57 INFO - ##### Running populate-webroot step. 05:44:57 INFO - ##### 05:44:57 INFO - Running pre-action listener: _resource_record_pre_action 05:44:57 INFO - Running main action method: populate_webroot 05:44:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:57 INFO - '--tppagecycles', 05:44:57 INFO - '7'], 05:44:57 INFO - 'tests': ['tsvgm']}}, 05:44:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:44:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:44:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'tests': ['damp', 'tps']}, 05:44:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['damp', 'tps']}, 05:44:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:44:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:57 INFO - 'other': {'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'other_l64': {'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'other_nol64': {'tests': ['a11yr', 05:44:57 INFO - 'ts_paint', 05:44:57 INFO - 'tpaint', 05:44:57 INFO - 'sessionrestore', 05:44:57 INFO - 'sessionrestore_no_auto_restore']}, 05:44:57 INFO - 'svgr': {'tests': ['tsvgx', 05:44:57 INFO - 'tsvgr_opacity', 05:44:57 INFO - 'tart', 05:44:57 INFO - 'tscrollx', 05:44:57 INFO - 'cart']}, 05:44:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['tsvgx', 05:44:57 INFO - 'tsvgr_opacity', 05:44:57 INFO - 'tart', 05:44:57 INFO - 'tscrollx', 05:44:57 INFO - 'cart']}, 05:44:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'tests': ['tp5o']}, 05:44:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'talos_options': ['--e10s'], 05:44:57 INFO - 'tests': ['tp5o']}, 05:44:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'talos_options': ['--xperf_path', 05:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:57 INFO - 'tests': ['tp5n']}, 05:44:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:57 INFO - 'talos_options': ['--e10s', 05:44:57 INFO - '--xperf_path', 05:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:57 INFO - 'tests': ['tp5n']}}, 05:44:57 INFO - 'talos.zip': {'path': '', 05:44:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:57 INFO - Running post-action listener: _resource_record_post_action 05:44:57 INFO - ##### 05:44:57 INFO - ##### Running create-virtualenv step. 05:44:57 INFO - ##### 05:44:57 INFO - Running pre-action listener: _resource_record_pre_action 05:44:57 INFO - Running main action method: create_virtualenv 05:44:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:44:57 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 05:44:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:44:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:58 INFO - Using real prefix '/usr' 05:44:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:44:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:45:00 INFO - Installing pip.................done. 05:45:00 INFO - Return code: 0 05:45:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:45:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:45:00 INFO - Using env: {'DISPLAY': ':0', 05:45:00 INFO - 'HOME': '/home/cltbld', 05:45:00 INFO - 'LANG': 'en_US.UTF-8', 05:45:00 INFO - 'LANGUAGE': 'en_US:en', 05:45:00 INFO - 'LOGNAME': 'cltbld', 05:45:00 INFO - 'MAIL': '/var/mail/cltbld', 05:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:00 INFO - 'MOZ_NO_REMOTE': '1', 05:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:00 INFO - 'NO_EM_RESTART': '1', 05:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:00 INFO - 'SHELL': '/bin/bash', 05:45:00 INFO - 'SHLVL': '1', 05:45:00 INFO - 'TERM': 'linux', 05:45:00 INFO - 'TMOUT': '86400', 05:45:00 INFO - 'USER': 'cltbld', 05:45:00 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:00 INFO - '_': '/tools/buildbot/bin/python'} 05:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:00 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 05:45:00 INFO - Cleaning up... 05:45:00 INFO - Return code: 0 05:45:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:45:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:45:00 INFO - Using env: {'DISPLAY': ':0', 05:45:00 INFO - 'HOME': '/home/cltbld', 05:45:00 INFO - 'LANG': 'en_US.UTF-8', 05:45:00 INFO - 'LANGUAGE': 'en_US:en', 05:45:00 INFO - 'LOGNAME': 'cltbld', 05:45:00 INFO - 'MAIL': '/var/mail/cltbld', 05:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:00 INFO - 'MOZ_NO_REMOTE': '1', 05:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:00 INFO - 'NO_EM_RESTART': '1', 05:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:00 INFO - 'SHELL': '/bin/bash', 05:45:00 INFO - 'SHLVL': '1', 05:45:00 INFO - 'TERM': 'linux', 05:45:00 INFO - 'TMOUT': '86400', 05:45:00 INFO - 'USER': 'cltbld', 05:45:00 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:00 INFO - '_': '/tools/buildbot/bin/python'} 05:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:00 INFO - Downloading/unpacking psutil>=0.7.1 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:45:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:45:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:02 INFO - Installing collected packages: psutil 05:45:02 INFO - Running setup.py install for psutil 05:45:02 INFO - building 'psutil._psutil_linux' extension 05:45:02 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 05:45:02 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 05:45:03 INFO - building 'psutil._psutil_posix' extension 05:45:03 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 05:45:03 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 05:45:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:45:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:45:03 INFO - Successfully installed psutil 05:45:03 INFO - Cleaning up... 05:45:03 INFO - Return code: 0 05:45:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:45:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:45:03 INFO - Using env: {'DISPLAY': ':0', 05:45:03 INFO - 'HOME': '/home/cltbld', 05:45:03 INFO - 'LANG': 'en_US.UTF-8', 05:45:03 INFO - 'LANGUAGE': 'en_US:en', 05:45:03 INFO - 'LOGNAME': 'cltbld', 05:45:03 INFO - 'MAIL': '/var/mail/cltbld', 05:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:03 INFO - 'MOZ_NO_REMOTE': '1', 05:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:03 INFO - 'NO_EM_RESTART': '1', 05:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:03 INFO - 'SHELL': '/bin/bash', 05:45:03 INFO - 'SHLVL': '1', 05:45:03 INFO - 'TERM': 'linux', 05:45:03 INFO - 'TMOUT': '86400', 05:45:03 INFO - 'USER': 'cltbld', 05:45:03 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:03 INFO - '_': '/tools/buildbot/bin/python'} 05:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:45:03 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 05:45:03 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 05:45:03 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 05:45:03 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 05:45:03 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 05:45:03 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 05:45:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:45:05 INFO - Installing collected packages: mozsystemmonitor 05:45:05 INFO - Running setup.py install for mozsystemmonitor 05:45:05 INFO - Successfully installed mozsystemmonitor 05:45:05 INFO - Cleaning up... 05:45:05 INFO - Return code: 0 05:45:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:45:05 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')]} 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 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')]} 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:45:05 INFO - Using env: {'DISPLAY': ':0', 05:45:05 INFO - 'HOME': '/home/cltbld', 05:45:05 INFO - 'LANG': 'en_US.UTF-8', 05:45:05 INFO - 'LANGUAGE': 'en_US:en', 05:45:05 INFO - 'LOGNAME': 'cltbld', 05:45:05 INFO - 'MAIL': '/var/mail/cltbld', 05:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:05 INFO - 'MOZ_NO_REMOTE': '1', 05:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:05 INFO - 'NO_EM_RESTART': '1', 05:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:05 INFO - 'SHELL': '/bin/bash', 05:45:05 INFO - 'SHLVL': '1', 05:45:05 INFO - 'TERM': 'linux', 05:45:05 INFO - 'TMOUT': '86400', 05:45:05 INFO - 'USER': 'cltbld', 05:45:05 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:05 INFO - '_': '/tools/buildbot/bin/python'} 05:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:45:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:45:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:45:07 INFO - Downloading docopt-0.6.1.tar.gz 05:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:45:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:45:08 INFO - Running setup.py install for blobuploader 05:45:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:45:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:45:08 INFO - Running setup.py install for requests 05:45:08 INFO - Running setup.py install for docopt 05:45:08 INFO - Successfully installed blobuploader requests docopt 05:45:08 INFO - Cleaning up... 05:45:08 INFO - Return code: 0 05:45:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:08 INFO - Using env: {'DISPLAY': ':0', 05:45:08 INFO - 'HOME': '/home/cltbld', 05:45:08 INFO - 'LANG': 'en_US.UTF-8', 05:45:08 INFO - 'LANGUAGE': 'en_US:en', 05:45:08 INFO - 'LOGNAME': 'cltbld', 05:45:08 INFO - 'MAIL': '/var/mail/cltbld', 05:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:08 INFO - 'MOZ_NO_REMOTE': '1', 05:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:08 INFO - 'NO_EM_RESTART': '1', 05:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:08 INFO - 'SHELL': '/bin/bash', 05:45:08 INFO - 'SHLVL': '1', 05:45:08 INFO - 'TERM': 'linux', 05:45:08 INFO - 'TMOUT': '86400', 05:45:08 INFO - 'USER': 'cltbld', 05:45:08 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:08 INFO - '_': '/tools/buildbot/bin/python'} 05:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:08 INFO - Running setup.py (path:/tmp/pip-SnLrf2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:08 INFO - Running setup.py (path:/tmp/pip-Pyx4wz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:09 INFO - Running setup.py (path:/tmp/pip-ODXeQ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:09 INFO - Running setup.py (path:/tmp/pip-OHevdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:09 INFO - Running setup.py (path:/tmp/pip-vLnjLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:09 INFO - Running setup.py (path:/tmp/pip-Yc2Vlx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:09 INFO - Running setup.py (path:/tmp/pip-agyLjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:09 INFO - Running setup.py (path:/tmp/pip-BwVYFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:09 INFO - Running setup.py (path:/tmp/pip-bvEZHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:09 INFO - Running setup.py (path:/tmp/pip-flQ7kS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:09 INFO - Running setup.py (path:/tmp/pip-AAJC5q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:09 INFO - Running setup.py (path:/tmp/pip-cCxQHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:09 INFO - Running setup.py (path:/tmp/pip-VPOGQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:09 INFO - Running setup.py (path:/tmp/pip-cEEIev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:09 INFO - Running setup.py (path:/tmp/pip-shb890-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:09 INFO - Running setup.py (path:/tmp/pip-Td0bkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:09 INFO - Running setup.py (path:/tmp/pip-gKz_2I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:45:10 INFO - Running setup.py install for manifestparser 05:45:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Running setup.py install for mozcrash 05:45:10 INFO - Running setup.py install for mozdebug 05:45:10 INFO - Running setup.py install for mozdevice 05:45:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Running setup.py install for mozfile 05:45:10 INFO - Running setup.py install for mozhttpd 05:45:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Running setup.py install for mozinfo 05:45:10 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Running setup.py install for mozInstall 05:45:10 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:45:10 INFO - Running setup.py install for mozleak 05:45:10 INFO - Running setup.py install for mozlog 05:45:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Running setup.py install for moznetwork 05:45:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Running setup.py install for mozprocess 05:45:11 INFO - Running setup.py install for mozprofile 05:45:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Running setup.py install for mozrunner 05:45:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Running setup.py install for mozscreenshot 05:45:11 INFO - Running setup.py install for moztest 05:45:11 INFO - Running setup.py install for mozversion 05:45:11 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:45:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:45:11 INFO - Cleaning up... 05:45:11 INFO - Return code: 0 05:45:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:45:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:11 INFO - Using env: {'DISPLAY': ':0', 05:45:11 INFO - 'HOME': '/home/cltbld', 05:45:11 INFO - 'LANG': 'en_US.UTF-8', 05:45:11 INFO - 'LANGUAGE': 'en_US:en', 05:45:11 INFO - 'LOGNAME': 'cltbld', 05:45:11 INFO - 'MAIL': '/var/mail/cltbld', 05:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:11 INFO - 'MOZ_NO_REMOTE': '1', 05:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:11 INFO - 'NO_EM_RESTART': '1', 05:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:11 INFO - 'SHELL': '/bin/bash', 05:45:11 INFO - 'SHLVL': '1', 05:45:11 INFO - 'TERM': 'linux', 05:45:11 INFO - 'TMOUT': '86400', 05:45:11 INFO - 'USER': 'cltbld', 05:45:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:11 INFO - '_': '/tools/buildbot/bin/python'} 05:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:12 INFO - Running setup.py (path:/tmp/pip-ed4JVq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:12 INFO - Running setup.py (path:/tmp/pip-zeUn3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:12 INFO - Running setup.py (path:/tmp/pip-IP4Z2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:12 INFO - Running setup.py (path:/tmp/pip-7U7T4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:12 INFO - Running setup.py (path:/tmp/pip-vYsPEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:12 INFO - Running setup.py (path:/tmp/pip-gmgkJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:12 INFO - Running setup.py (path:/tmp/pip-Q7hpJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:12 INFO - Running setup.py (path:/tmp/pip-lZxOCa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:12 INFO - Running setup.py (path:/tmp/pip-PjYgb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:12 INFO - Running setup.py (path:/tmp/pip-G7zHH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:12 INFO - Running setup.py (path:/tmp/pip-QdVnbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:12 INFO - Running setup.py (path:/tmp/pip-gJUQFr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:45:12 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)) 05:45:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:12 INFO - Running setup.py (path:/tmp/pip-UBhoK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:45:13 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)) 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:13 INFO - Running setup.py (path:/tmp/pip-e5iktz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:45:13 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)) 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:13 INFO - Running setup.py (path:/tmp/pip-peI7A9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:45:13 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)) 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:13 INFO - Running setup.py (path:/tmp/pip-kKoDsr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:45:13 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)) 05:45:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:13 INFO - Running setup.py (path:/tmp/pip-qcC13S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 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)) 05:45:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:13 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 05:45:14 INFO - Downloading blessings-1.5.1.tar.gz 05:45:14 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:45:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:45:15 INFO - Installing collected packages: blessings 05:45:15 INFO - Running setup.py install for blessings 05:45:15 INFO - Successfully installed blessings 05:45:15 INFO - Cleaning up... 05:45:15 INFO - Return code: 0 05:45:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:45:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:15 INFO - Reading from file tmpfile_stdout 05:45:15 INFO - Current package versions: 05:45:15 INFO - argparse == 1.2.1 05:45:15 INFO - blessings == 1.5.1 05:45:15 INFO - blobuploader == 1.2.4 05:45:15 INFO - docopt == 0.6.1 05:45:15 INFO - manifestparser == 1.1 05:45:15 INFO - mozInstall == 1.12 05:45:15 INFO - mozcrash == 0.16 05:45:15 INFO - mozdebug == 0.1 05:45:15 INFO - mozdevice == 0.47 05:45:15 INFO - mozfile == 1.2 05:45:15 INFO - mozhttpd == 0.7 05:45:15 INFO - mozinfo == 0.9 05:45:15 INFO - mozleak == 0.1 05:45:15 INFO - mozlog == 3.1 05:45:15 INFO - moznetwork == 0.27 05:45:15 INFO - mozprocess == 0.22 05:45:15 INFO - mozprofile == 0.27 05:45:15 INFO - mozrunner == 6.11 05:45:15 INFO - mozscreenshot == 0.1 05:45:15 INFO - mozsystemmonitor == 0.0 05:45:15 INFO - moztest == 0.7 05:45:15 INFO - mozversion == 1.4 05:45:15 INFO - psutil == 3.1.1 05:45:15 INFO - requests == 1.2.3 05:45:15 INFO - wsgiref == 0.1.2 05:45:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:45:15 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')]} 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 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')]} 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:45:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:45:15 INFO - Using env: {'DISPLAY': ':0', 05:45:15 INFO - 'HOME': '/home/cltbld', 05:45:15 INFO - 'LANG': 'en_US.UTF-8', 05:45:15 INFO - 'LANGUAGE': 'en_US:en', 05:45:15 INFO - 'LOGNAME': 'cltbld', 05:45:15 INFO - 'MAIL': '/var/mail/cltbld', 05:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:15 INFO - 'MOZ_NO_REMOTE': '1', 05:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:15 INFO - 'NO_EM_RESTART': '1', 05:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:15 INFO - 'SHELL': '/bin/bash', 05:45:15 INFO - 'SHLVL': '1', 05:45:15 INFO - 'TERM': 'linux', 05:45:15 INFO - 'TMOUT': '86400', 05:45:15 INFO - 'USER': 'cltbld', 05:45:15 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:15 INFO - '_': '/tools/buildbot/bin/python'} 05:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 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)) 05:45:15 INFO - Cleaning up... 05:45:15 INFO - Return code: 0 05:45:15 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:45:15 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')]} 05:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 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')]} 05:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:45:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:45:15 INFO - Using env: {'DISPLAY': ':0', 05:45:15 INFO - 'HOME': '/home/cltbld', 05:45:15 INFO - 'LANG': 'en_US.UTF-8', 05:45:15 INFO - 'LANGUAGE': 'en_US:en', 05:45:15 INFO - 'LOGNAME': 'cltbld', 05:45:15 INFO - 'MAIL': '/var/mail/cltbld', 05:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:15 INFO - 'MOZ_NO_REMOTE': '1', 05:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:15 INFO - 'NO_EM_RESTART': '1', 05:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:15 INFO - 'SHELL': '/bin/bash', 05:45:15 INFO - 'SHLVL': '1', 05:45:15 INFO - 'TERM': 'linux', 05:45:15 INFO - 'TMOUT': '86400', 05:45:15 INFO - 'USER': 'cltbld', 05:45:15 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:15 INFO - '_': '/tools/buildbot/bin/python'} 05:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:15 INFO - Downloading/unpacking jsonschema 05:45:15 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 05:45:15 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 05:45:15 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 05:45:15 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 05:45:15 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 05:45:15 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 05:45:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:45:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:45:17 INFO - Downloading/unpacking functools32 (from jsonschema) 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 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 05:45:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:45:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:45:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:45:17 INFO - warning: no files found matching '*.txt' 05:45:17 INFO - no previously-included directories found matching 'build' 05:45:17 INFO - no previously-included directories found matching 'dist' 05:45:17 INFO - no previously-included directories found matching '.git*' 05:45:17 INFO - Installing collected packages: jsonschema, functools32 05:45:17 INFO - Running setup.py install for functools32 05:45:17 INFO - warning: no files found matching '*.txt' 05:45:17 INFO - no previously-included directories found matching 'build' 05:45:17 INFO - no previously-included directories found matching 'dist' 05:45:17 INFO - no previously-included directories found matching '.git*' 05:45:17 INFO - Successfully installed jsonschema functools32 05:45:17 INFO - Cleaning up... 05:45:17 INFO - Return code: 0 05:45:17 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:45: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')]} 05:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45: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')]} 05:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a4325df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, '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': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', '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 05:45:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:45:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:45:17 INFO - Using env: {'DISPLAY': ':0', 05:45:17 INFO - 'HOME': '/home/cltbld', 05:45:17 INFO - 'LANG': 'en_US.UTF-8', 05:45:17 INFO - 'LANGUAGE': 'en_US:en', 05:45:17 INFO - 'LOGNAME': 'cltbld', 05:45:17 INFO - 'MAIL': '/var/mail/cltbld', 05:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:17 INFO - 'MOZ_NO_REMOTE': '1', 05:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:17 INFO - 'NO_EM_RESTART': '1', 05:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:17 INFO - 'SHELL': '/bin/bash', 05:45:17 INFO - 'SHLVL': '1', 05:45:17 INFO - 'TERM': 'linux', 05:45:17 INFO - 'TMOUT': '86400', 05:45:17 INFO - 'USER': 'cltbld', 05:45:17 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:17 INFO - '_': '/tools/buildbot/bin/python'} 05:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:45:18 INFO - Downloading/unpacking flake8 05:45:18 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 05:45:18 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 05:45:18 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 05:45:18 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 05:45:18 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 05:45:18 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 05:45:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:45:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:45:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:19 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 05:45:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:45:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:45:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:45:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 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 05:45:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:45:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:45:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:20 INFO - no previously-included directories found matching 'docs/_build' 05:45:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:45:20 INFO - Running setup.py install for pep8 05:45:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:45:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:45:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:45:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:45:20 INFO - no previously-included directories found matching 'docs/_build' 05:45:20 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:45:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:45:20 INFO - Cleaning up... 05:45:25 INFO - Return code: 0 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - Running post-action listener: _start_resource_monitoring 05:45:25 INFO - Starting resource monitoring. 05:45:25 INFO - ##### 05:45:25 INFO - ##### Running install step. 05:45:25 INFO - ##### 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: install 05:45:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:45:25 INFO - Reading from file tmpfile_stdout 05:45:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:45:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:45:25 INFO - Reading from file tmpfile_stdout 05:45:25 INFO - Output received: 05:45:25 INFO - Usage: mozinstall [options] installer 05:45:25 INFO - Options: 05:45:25 INFO - -h, --help show this help message and exit 05:45:25 INFO - -d DEST, --destination=DEST 05:45:25 INFO - Directory to install application into. [default: 05:45:25 INFO - "/builds/slave/test-pgo"] 05:45:25 INFO - --app=APP Application being installed. [default: firefox] 05:45:25 INFO - mkdir: /builds/slave/test-pgo/build/application 05:45:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:45:44 INFO - Reading from file tmpfile_stdout 05:45:44 INFO - Output received: 05:45:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:45:44 INFO - Running post-action listener: _resource_record_post_action 05:45:44 INFO - ##### 05:45:44 INFO - ##### Running run-tests step. 05:45:44 INFO - ##### 05:45:44 INFO - Running pre-action listener: _resource_record_pre_action 05:45:44 INFO - Running main action method: run_tests 05:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:45:44 INFO - Python 2.7.3 05:45:44 INFO - Return code: 0 05:45:44 INFO - grabbing minidump binary from tooltool 05:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:44 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 0x2c89350>, '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 0x2c8a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:45:44 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 05:45:44 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 05:45:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:44 INFO - Return code: 0 05:45:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:45:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:45:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:45:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:45:45 INFO - Return code: 0 05:45:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:45:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 05:45:45 INFO - Using env: {'DISPLAY': ':0', 05:45:45 INFO - 'HOME': '/home/cltbld', 05:45:45 INFO - 'LANG': 'en_US.UTF-8', 05:45:45 INFO - 'LANGUAGE': 'en_US:en', 05:45:45 INFO - 'LOGNAME': 'cltbld', 05:45:45 INFO - 'MAIL': '/var/mail/cltbld', 05:45:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:45 INFO - 'MOZ_NO_REMOTE': '1', 05:45:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:45 INFO - 'NO_EM_RESTART': '1', 05:45:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:45:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:45:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:45:45 INFO - 'SHELL': '/bin/bash', 05:45:45 INFO - 'SHLVL': '1', 05:45:45 INFO - 'TERM': 'linux', 05:45:45 INFO - 'TMOUT': '86400', 05:45:45 INFO - 'USER': 'cltbld', 05:45:45 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829', 05:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:45 INFO - '_': '/tools/buildbot/bin/python'} 05:45:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 05:45:45 INFO - mozversion INFO | application_buildid: 20151217030207 05:45:45 INFO - mozversion INFO | application_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 05:45:45 INFO - mozversion INFO | application_display_name: Nightly 05:45:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:45 INFO - mozversion INFO | application_name: Firefox 05:45:45 INFO - mozversion INFO | application_remotingname: firefox 05:45:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:45:45 INFO - mozversion INFO | application_vendor: Mozilla 05:45:45 INFO - mozversion INFO | application_version: 46.0a1 05:45:45 INFO - mozversion INFO | platform_buildid: 20151217030207 05:45:45 INFO - mozversion INFO | platform_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 05:45:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:45:45 INFO - mozversion INFO | platform_version: 46.0a1 05:45:45 INFO - 2015-12-17 05:45:45,445 DEBUG : using testdate: 1450359945 05:45:45 INFO - 2015-12-17 05:45:45,445 DEBUG : actual date: 1450359945 05:45:45 INFO - 2015-12-17 05:45:45,493 INFO : starting webserver on 'localhost:58778' 05:45:45 INFO - 2015-12-17 05:45:45,494 INFO : Starting test suite talos-linux64-ix-013.e 05:45:45 INFO - 2015-12-17 05:45:45,494 INFO : Starting test dromaeo_css 05:45:45 INFO - 2015-12-17 05:45:45,494 DEBUG : operating with platform_type : linux_ 05:45:45 INFO - 2015-12-17 05:45:45,495 INFO : Initialising browser for dromaeo_css test... 05:45:45 INFO - 2015-12-17 05:45:45,505 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb5KDQc/profile http://localhost:58778/getInfo.html 05:46:35 INFO - 2015-12-17 05:46:35,389 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:46:35 INFO - 2015-12-17 05:46:35,389 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:46:35 INFO - 2015-12-17 05:46:35,389 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 05:46:35 INFO - 2015-12-17 05:46:35,390 DEBUG : BROWSER_OUTPUT: __metrics 05:46:35 INFO - 2015-12-17 05:46:35,982 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:46:36 INFO - 2015-12-17 05:46:36,750 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:46:40 INFO - 2015-12-17 05:46:40,525 INFO : Browser initialized. 05:46:40 INFO - 2015-12-17 05:46:40,525 INFO : Running cycle 1/1 for dromaeo_css test... 05:46:40 INFO - 2015-12-17 05:46:40,526 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb5KDQc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:46:52 INFO - 2015-12-17 05:46:52,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 143482880 05:46:52 INFO - 2015-12-17 05:46:52,414 DEBUG : BROWSER_OUTPUT: 05:47:42 INFO - 2015-12-17 05:47:42,038 DEBUG : BROWSER_OUTPUT: 1450360062038 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] 05:49:51 INFO - 2015-12-17 05:49:51,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58778/tests/dromaeo/cssquery-ext.html) 05:49:52 INFO - 2015-12-17 05:49:52,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 150880256 05:49:52 INFO - 2015-12-17 05:49:52,414 DEBUG : BROWSER_OUTPUT: 05:52:54 INFO - 2015-12-17 05:52:54,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-ext.html (next: http://localhost:58778/tests/dromaeo/cssquery-jquery.html) 05:52:55 INFO - 2015-12-17 05:52:55,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 145125376 05:52:55 INFO - 2015-12-17 05:52:55,004 DEBUG : BROWSER_OUTPUT: 05:55:56 INFO - 2015-12-17 05:55:56,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58778/tests/dromaeo/cssquery-mootools.html) 05:55:57 INFO - 2015-12-17 05:55:57,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 145788928 05:55:57 INFO - 2015-12-17 05:55:57,271 DEBUG : BROWSER_OUTPUT: 05:58:58 INFO - 2015-12-17 05:58:58,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58778/tests/dromaeo/cssquery-prototype.html) 05:58:59 INFO - 2015-12-17 05:58:59,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 144232448 05:58:59 INFO - 2015-12-17 05:58:59,553 DEBUG : BROWSER_OUTPUT: 06:02:01 INFO - 2015-12-17 06:02:01,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58778/tests/dromaeo/cssquery-yui.html) 06:02:02 INFO - 2015-12-17 06:02:02,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 145334272 06:02:02 INFO - 2015-12-17 06:02:02,471 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/dromaeo/cssquery-yui.html (next: http://localhost:58778/tests/dromaeo/cssquery-dojo.html) 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: RSS: Main: 147353600 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:05:05 INFO - 2015-12-17 06:05:05,274 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:05:05 INFO - 2015-12-17 06:05:05,275 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3207.599050118735;3253.934921301574;3285.3429314137165;3285.35935492579;3290.4899740540195;5260.079486089938;5420.024395608789;5459.972700136494;5463.96184724903;5471.6443431176995;5383.300170977777;5435.565154787618;5459.563234941205;5464.043792336335;5473.2063850741615;4915.877103072425;4974.3533340665845;5028.597712183035;5063.873403164914;5073.264376665381;4974.577160941306;5051.747412629372;5065.848024559251;5076.13705670037;5149.17613181891;4828.806847726087;4921.163402221631;4921.286413470027;4941.901161976758;5015;4907.1657818171;4947.925781113287;4948.653594248404;4951.950480495185;4959.8016079356785;4873.074115917964;5003.424606170301;5012.097822391968;5033.421156567005;5043.268726034741;5155.40712818027;5280.339957505312;5285.577153827685;5320.65415747979;5353.170258609922;5759.856003599902;5794.768209271666;5805.187273781674;5813.912791308134;5834.066549352084;5786.739596718157;5787.971060144714;5789.536837053026;5819.301683797971;5839.9124013139835;5327.493888080626;5419.918701219485;5429.891402171935;5502.504774570308;5620.241267428926;5948.226730525004;5956.583039187302;5957.523398128139;5962.433568810956;5975.043992961106;5713.942860571341;5732.512736417451;5759.971200143972;5761.53907687384;5770.596058275881;5647.124695672095;5718.199452076713;5746.482816546531;5752.769889204469;5761.279840019997;5734.254546908875;5763;5784.421557844182;5792.594518383757;5795.710214489259;5683.54531637468;5732.054211055212;5752.137179423036;5757.395473475309;5767.538596912237;4365.563443655673;4386.342048692658;4472.127935052634;4486.1252055849445;4509.481409637933;4039.434479172918;4043.251998380309;4044.292248856438;4049.9392509112386;4083.1629515949157;5658.462446067617;5670.262865827416;5671.631343962629;5677.2619559457835;5687.459691329317;5789.478946894716;5799.8550036249435;5858.736356863951;5945.197398351167;5958.374370691015;5618.775248990077;5632.690202038927;5639.6334238274385;5674.375818659944;5697.743601537941;5089.211172268304;5106.974465127651;5148;5153.123968925292;5183.0670479314085;5854.4730974212525;5955.731992060368;6001.639901605918;6040.60736052164;6109.877802443926;5771.826845194651;5925.585209035326;5971.4327138921735;5975.551833612583;5979.701014949148;6068.089786531879;6103.969480152571;6130.386961303834;6152.077188421773;6159.938400616115;5702.714864256854;5760.135979603093;5812.099124635688;5854.9121763174435;5898.528117750656;5876.147958546072;5918.881622367615;5931.792387266425;5937.703114844327;5946.762129514944;5624.943750562606;5766.019776637898;5781.739821708117;5784.2769653793275;5784.652920824764;5688.77244910199;5700.714964251688;5710.628809127394;5753.1370294456165;5800.042992906123;5629.971850140723;5634.605577609692;5646.491815736604;5655.123455864347;5659.03796354629;5618.971905140448;5777.162311464898;5793.391693872083;5803.709814509173;5812;5547.11246200606;5569.44305569456;5577.693226872561;5612.158176273591;5660.971695141498 06:05:05 INFO - 2015-12-17 06:05:05,275 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.6968449931413;586.6597373523356;606.5238787551773;618.656645561713;621.5307442880625;37187.25625487488;37997.81001094998;38083.619163808355;38084.61915380845;38147;42168;42614.57385426153;42686.7865660672;42756.57243427565;42941.570584294146;8573.52845593492;8662.52356120413;8724.738257852274;8746.86879696805;8781.604827782734;8521.872171917426;8622.568871556397;8647;8677.522736249504;8685.609147588342;8590.153117079826;8622.223999840013;8647.783805404852;8694.652213911437;8717.215450609443;8603.870941935844;8622.525761083138;8649.567521623894;8692.652293908268;8699;8467.66129354825;8574.399792014561;8598.742037738877;8608.612612432393;8653.870191947126;39344.21311573781;39496.21007579832;39695.8015209925;39701.80149099265;39923.40114898279;3217.7104060634656;3261.9347613047844;3338.6160591532043;3400.0649821299094;3510.8771193008124;29477;30314.242143946358;30326.090217293517;30337.544936825965;30769.692303076907;3864.536255649312;3995.200959808021;4074.816633251481;4116.773577453238;4173.123644034757;261988;264833;264845;265107;265388;57902.13146802801;58064.70967645135;58258.708706457044;58400.41599584035;58405.12392314119;62547.68726156431;62880.685596571726;63085;68766.31233687699;69569;13199.340032998312;13230.867691323156;13314.467421303234;13318.600441986757;13384.799228011587;9558.761030974281;9610.183134433511;9615.653808466821;9632.9036709632;9670.951645241728;20202.191912323637;20271.695924561143;20456.284030059174;20481.89759051195;20535;7772.727954521678;8144.348452123816;8144.389170812095;8157.14349993254;8191.221833925768;923.2533213689221;935.6444551070686;986.5954958466995;998.3859926145368;1018.9439580822977;27945.668421394716;27968;28061.859690701825;28138.577921331198;28325.858370708014;1056.8203405421098;1060.2525219720078;1067.8665166854144;1101.8347247912877;1116.8715597706205;14847.406103755944;16516;17287.394941176997;17381.565460863327;17410.65178696419;386527;389248;391316;391379;392817;53802.461975379745;54224.45775542194;54573.181402279;54656;54675.453245467834;1312.1667740984353;1332.460353556811;1332.8600496947874;1343.4760443427072;1345.051738524338;28301.292467688472;29188.416231674822;29503.409931800816;29515.55726664059;29869.70130298669;43658.781706091264;44332;44432.55567444284;44437.77781111074;44478.77760611176;290095;292570;293586;293970;295875;31486.52770208403;45149.322760157964;45353.77323113364;46037.309440359095;46210.306845398016;42213.78893105515;42229.36655950102;42389;42607;42835.357469637354;35027.47458788171;35212.67748024071;35324.29351412906;35345.64654353423;35736.463953041246;35232.471512926815;35768;35821.28357432889;36099.819500902326;36172.27655446929;35228.295434091684;35270.47094293639;35277;35673.1081722959;35728;31452.213694657818;32146.839265803523;32496.02511924646;32678.673213267564;32745.18137046593;24321.270361889172;24433.51132977366;24505;24822.37944051341;24940.75059249457 06:05:05 INFO - 2015-12-17 06:05:05,275 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.12148115635534;358.32455820777824;362.069481432718;362.55586906040105;362.7098321342926;16626.75059874103;17446.30214791407;17866.374676886313;18282.451526454228;19064;14641;14728.116313021226;14759.409623615069;14815.925920370382;14922.253887305646;4617.60750336221;4801.879953001168;4802.567768900798;4810.326554282386;4820.035992801436;4809.422869255694;4811.951880481185;4912;5408.540274076709;5432.076546987022;5143.768530416121;5250.842474725764;5360.490753378423;5363.785448582052;5370.624056316059;5252.159654455307;5264.394594621629;5271;5286.629935904508;5289.629725919187;5106.208537676666;5327.813526526592;5342.065138600729;5342.732863356856;5348.679079255257;12313.384330783425;12530.81203781944;15234.466793662168;20570.5885882283;20573.382798516068;2054.8869812160324;2064.060852312194;2124.7237859078377;2132.3709505695856;2282.3038973113194;9969.302148849583;10776.946115269451;12137.878621213764;12829.486820527261;13158.736825263537;1820.2082094289026;1885.70771530413;1894.062439092658;1902.4102528216158;1937.3800383877165;59843;63250.68374658097;63743;64548.354516455176;64703;9994.850077248848;10190.643327483502;10297.691069267934;10303.742406439898;10331.276810623183;13439.126456780277;13624.86375136236;13641.727165456636;13646.795298070538;13660.112092713942;6959.304069593;7043.225245223021;7060.364567188978;7087.751928682472;7093.503454758117;6665.866682666319;6680.031395447633;6682.9331706682315;6702.36327548882;6716.529842910949;4430.8449204277695;4462.241418958784;4477.686561940698;4485.058137791035;4512.548745125527;1794.3271273272524;1840.6226723521645;1852.740616313717;1875;1876.718492226177;405.0178317579916;441.2785096367462;455.462554186057;458.0861181942047;464.09733069180123;10434.739131521621;10781.191410644233;10991.285566438157;11082.667519974413;11186.608468703556;448.13733562891304;460.4589607211513;462.6853739457134;465.2277219815091;485.3011663204974;9615.9038409615;10145.898541014643;10211.336263142872;10249.795004099877;10321;498350;500900;503106;506467;508077;82623.58688206521;83270.58364708138;83557;85441.57279213688;85789.57105214434;1150.5915400033034;1162.2155045344527;1164.7204670878928;1173.266708307308;1185.0993245133761;15991.68016639684;16082.919585401998;16198.352065917232;16267.51197464078;16434.424795132112;36241;36623.08442288964;36903.63096369002;38032.429513556766;38633;47133.528664714286;48200.27699584439;49016;49175.75412122916;53021.204681930576;9338.299627528098;9623.326367154232;9626.759331016781;9648.372855764354;9685.757856053655;17075.146242688064;17614.91192544029;17860.642787144443;17925.551861203574;18533.258669653063;14501.20243386624;14514.709705806035;15023.399064037316;15560.144192069092;15575.766363504783;13817.516386926409;14155.929220353832;14372.712545749235;14403.78394324065;14608.488702895773;14007.789883151558;14213.644658883197;14596.781048284496;15059.472918447802;15115.697686045998;9230.630774768933;9304.30217733659;9405.81188376215;9482.668106616235;9518.286128540249;10133.18934485254;10248.846267306146;12611.36943152857;14926.850731492546;15311.081335119929 06:05:05 INFO - 2015-12-17 06:05:05,275 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1444.234555685487;1705.8550023248026;1752.6669932712784;1756.3325936144263;1761.040233072975;6790.354916282945;7001.509894307401;7439.442041846863;7814.960925195373;7842.843143137134;7200.063991681074;7316.451266155046;7401.296876796696;7416.703331866733;7453.701851925916;2056.424201223656;2087.6451003329394;2097.1087287902656;2098.2760947473175;2100.8634438761433;2078.7089807426973;2088.812006919377;2098.03490394418;2168.403688985534;2176.934691959236;2093.173196587347;2093.822025127866;2108.968365474519;2111.7043613894066;2124.9043793029273;2055.342290467051;2060.103854823149;2069.503319203388;2069.8965051747505;2070.6169358668694;2062.577171679817;2063.4428704249917;2085.6558667819945;2099.5695882344235;2101.95796084079;7679.232076792332;7717.65270562826;7757.961210193969;7768.53388796674;7771.572563509005;4465.196264672358;4495.280755079171;4532.9320060199125;4550.067236216601;4552.248878934972;2886.5381538953666;2916.6500019997734;2917;2926.926826829325;2935.2074939766358;892.067789160329;926.4070994563485;945.3099237556553;953.5327689432198;967.6564819489121;10713.625023124154;10718.410487423189;10742.516586753614;10746.946265268623;10762.892371076345;4118.5263694674895;4149.294619914562;4185.748855068706;4188;4226.36604509326;9153.908460915438;9174.816503670023;9215.53922303882;9243.26053915685;9253.213476854542;4462.642988560908;4469.4860091089295;4487.125010622897;4492.460904691393;4496.123255965055;4038;4045.4538637284177;4065;4152.875413737593;4161.292580261363;3376.1559610097474;3392.2876195999115;3394.9151271218416;3410.471376936579;3413.0955296846355;1046.100353695821;1046.947652617366;1049.8057859296055;1056.8731752189785;1058.9788204236027;1324.5099313254157;1326.0783755290174;1327.9402426890813;1339.055965544289;1345.3407830163346;7344.596047217347;7357.5217610855125;7440.10718713747;7455.254474552501;7470.813229669302;463.4484962894145;471.7146126593362;493.575525048458;498.05866911537225;498.4990084964587;5771.94228057714;5785.566082543826;5811.622244554091;5822.941770582324;5834.912476312858;8921.286297096216;9463.43219406824;9468.90531094694;9482.099200576073;9506.096920792514;9189.632414703337;9215.124563166488;9275.628974841065;9308.301877359225;9376.765580860532;6792.320767923267;6994.860102797916;6995.1955525114245;6996.405305549085;7064.32888875556;7336.266373362621;7361.1166659999;7368.59472729005;7415.184329723618;7415.184329723834;7611.162772094955;7682.577458239851;7875.212478752079;7910.52536847791;8027.317677997436;7956.84086318282;7957.403194760301;7976.481528700848;7997.720079797179;8021.398395120273;6345.111684364285;6593.307702691341;6732.697028633821;6810.897836532555;6876.277990810893;7267.7819665410125;7310.634468276458;7320.780376588711;7325.120985481776;7325.597092159769;6648.601083934979;6836;6875.243723190345;6968.407685346802;7029.0862187915245;6705.295943926013;6724.058631791651;6829.043933849364;6833.3166683331265;6856.657167141523;6787.185537735306;6812.795616131524;6832.863342733217;6838.623875686686;6883.3116688330765;6308.684565771601;6367.554271200971;6369.9681501592195;6371.044343348535;6373.203349581302;6324.462420694293;6378.298387177314;6381.202349706286;6383.744650213939;6425.58233714807 06:05:05 INFO - 2015-12-17 06:05:05,276 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.9572107765451;329.1130403562399;337.94086034943876;339.3619994410508;342.6795945790684;6325.557210995232;6338;6374.840628984278;6407.359264073591;6425.100485931974;6215.875682486348;6311.116443697886;6314.368563143684;6315.589486683362;6326.525510586713;4857.392825896763;4858.82994095205;4859.2225243960975;4866.391701037371;4868.367112275399;4834.2990266411525;4840.854774356757;4842.806287748504;4849.830255941043;4858.295547145662;4719.056188762244;4771.665983381165;4801.68789028712;4814.855554333358;4837.371141751585;4784.330193772875;4788.449328327235;4805.783739731721;4816.7350795706225;4818.397700287464;4219.810108545123;4230.238557059728;4231.513375961773;4231.576842315774;4231.87304380869;5932.7330270137945;5959.940400595982;5987.491063259585;5991.580589358747;6006.579539432241;5502.734371094671;5669.433056694339;5679.346875109374;5679.574031947621;5686.800961966353;6690.565113267622;6694.899576506356;6703.865922681519;6713;6717.395434410926;4693.225617773063;4700.741459219742;4701.224297990828;4702.694324868872;4713.151632706112;6823.215330236987;6924.4114250288785;7006.859862802716;7020.368166865007;7021.82445438863;4852.56326930578;4858.3441235432765;4866.513348665176;4866.635002374836;4873.95126048735;4918.532739389752;4919.917618124007;4925.38432695913;4928.334674818925;4928.901421971541;5556.666600004012;5645.181448689917;5654.208410822488;5664.54683625309;5671.51792097668;6730.461563074942;6747.595144291358;6772.187337519431;6776.627285499345;6785.830354241183;1687.957801054959;1720.9483715488554;1746.938857139994;1747.1788259518007;1747.9213435395438;1155.5608868629868;1161.8315344275034;1183.627157445402;1187.3766272706898;1192.8210768384638;6318.494520438354;6386.393292637192;6396.0725694774;6401.455876250478;6407.7436902524305;6791.422729068085;6829.93170068293;6860.108185935796;6871.244163142051;6879.140107486564;6327.462165715873;6412.97392417211;6427.517936154807;6431.324710905381;6435.517336199804;3742.719296052807;3764.5670747863796;3768.2275133597545;3770.4344348347418;3770.6606405423645;7172.641367931583;7175.246599107123;7175.712971481186;7178.318059784312;7183.96408017967;6807.727690892408;6904.827379315558;6953.687084081127;6960.095187625678;6986.685599148051;7015.403690686247;7052.858942821114;7066.434685225273;7081.929180708127;7155.713771449188;6813.557118787263;6853.246142924374;6865.759698410531;6883.070785443901;6896.93103068983;6627.403533681992;6786.253512113763;6793.184817821893;6809.421199198124;6825.863482730417;7152.392046676091;7160.713571457083;7162.531681005277;7169.856602868018;7174;4843.927341089957;4845.297431872429;4846.103470857903;4854.2233242681;4866.221404575251;6748.561343512656;6835.179778426621;6847.281035491202;6872.41584465326;6879.484038697017;6609.966950165219;6645.102911107132;6668.699908504226;6675.9666201670625;6679.131712877295;6653.035309880137;6662.100616416916;6663.7001334941015;6666.533342665967;6679.0649309097735;6409.038644203407;6532.346765323429;6552.508561857784;6552.868942621216;6564.310747371457;6695.12963314766;6700.731970721116;6704.296048914989;6708.597484150967;6710.328967103251;6436.645984470899;6496.7726129585235;6505.251896032017;6523.021546768023;6529.608223506605 06:05:05 INFO - 2015-12-17 06:05:05,276 DEBUG : BROWSER_OUTPUT: |5;yui.html;723.1755798389834;773.1379511844292;776.5961699916043;845.4124383553429;876.0801158783278;13023.218606883582;13280.734385312287;13292.933535332333;13390.062695611312;13410.597682069541;11828.645140645795;11878.940605296983;11922.761544769099;12329.321887296195;12786.104972651918;828.4780588229407;836.8619177835665;842.5323945210406;843.5402705525503;844.3667249562828;834.3116928533954;834.5743670727942;836.1304243586662;836.8284501677172;841.9938173882214;871.6818361298112;872.6334939325467;876.2508055612456;877.868319752036;878.5299864572455;867.41449521573;868.3704314372061;870.4951128345544;871.6339137562176;873.8470767615642;636.4272155060436;638.4222278837659;640.4140211706283;641.9486441084701;644.4876323322923;13547;13570.45718171272;13573.52492662752;13592.660183495393;13599.728005439934;11714.180007399485;11760.117991150699;11775;11862.762744745056;11974.760504789943;10289.434081125535;10335.741606459824;10357.274990750651;10422.322549034365;10464.738381540446;3586.910327241814;3633.94549081764;3641.0715267606856;3689.594144644087;3715.981420092909;47886.76056619729;47953.04093918137;48027.27959080617;48179.75910120462;48243.99999999965;9527.618895244252;9913.603455861685;10141.442220677785;10216.693499195037;10220.6422775204;17245.310187592357;17425.215865286093;17436.91281543584;17461.65076698459;17471.825281747275;6966.303369663095;7061.505694601328;7063.470239732041;7065.752698655625;7074.186468556079;4149.875503734893;4211.305134652748;4286.7856607169515;4307.676924230633;4309.525952145262;3017.5775391445213;3018.83396413195;3044.1628552148336;3053.3740583180393;3060.1890499017777;538.0637690418722;538.2276433318201;539.7894821019805;553.1923391847947;553.7314402514777;627.9528439209344;666.0342503370133;672.7981605518324;682.8327059870363;709.7054722290192;8554.700585479479;8593.95703021481;8771.16673915977;8857.911420885837;8918.643254269757;567.9744411501492;677.993220067793;693.931345727584;704.3871831506622;731.0313834169747;4019.196160767858;4140.192662430857;4175.081482074;4215.241256573785;4239.236937351245;55562.44437555654;55954.72022639942;56241.43758562362;56262;56515;50652.74673626682;50661.49338506642;51158.23262651063;51465.22802157971;51883.22175167376;45264;45723.31415028777;45870.31194532085;46415.535844641796;46503.5349646506;8092.190780921861;8188.385871059575;8284.08875023759;8294.377921656021;8313.915277528818;33722.83138584292;34043.14892127617;34321.14197145091;34461.31077378388;34603.30793384169;40175.59824401836;40362.394564080976;44194.337084944396;44353.33469997888;44549.33176002427;9502.140526300065;9924.751881203028;9971.152452041657;10291.639792607222;10394.168466522811;11617.128715346214;11626.476808543466;11649.126315526539;11857.110716696456;11917.22538035025;10923.945380273048;11024.519864759257;11115.83326250123;11137.443127843737;11452.083833293484;10751.462426878468;10866.67399978002;10965.451727413756;11086.057685096857;11472.369019703996;10474.581016759244;10650.73373165677;10792;10924.18068644839;11008.229423940247;9405.294602904947;9446.197073248852;9489.85765213536;9775.014742481528;9865.506724663881;8886.777830554287;8962.238209752244;9037.954810225907;9727.367721098106;10162.441065741456 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: __startTimestamp1450361105267__endTimestamp 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:05:05 INFO - 2015-12-17 06:05:05,277 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,278 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5437.11 Median:5670.26 stddev:600.00 (10.6%) stddev-sans-first:575.79 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: Values: 3207.6 3253.9 3285.3 3285.4 3290.5 5260.1 5420.0 5460.0 5464.0 5471.6 5383.3 5435.6 5459.6 5464.0 5473.2 4915.9 4974.4 5028.6 5063.9 5073.3 4974.6 5051.7 5065.8 5076.1 5149.2 4828.8 4921.2 4921.3 4941.9 5015.0 4907.2 4947.9 4948.7 4952.0 4959.8 4873.1 5003.4 5012.1 5033.4 5043.3 5155.4 5280.3 5285.6 5320.7 5353.2 5759.9 5794.8 5805.2 5813.9 5834.1 5786.7 5788.0 5789.5 5819.3 5839.9 5327.5 5419.9 5429.9 5502.5 5620.2 5948.2 5956.6 5957.5 5962.4 5975.0 5713.9 5732.5 5760.0 5761.5 5770.6 5647.1 5718.2 5746.5 5752.8 5761.3 5734.3 5763.0 5784.4 5792.6 5795.7 5683.5 5732.1 5752.1 5757.4 5767.5 4365.6 4386.3 4472.1 4486.1 4509.5 4039.4 4043.3 4044.3 4049.9 4083.2 5658.5 5670.3 5671.6 5677.3 5687.5 5789.5 5799.9 5858.7 5945.2 5958.4 5618.8 5632.7 5639.6 5674.4 5697.7 5089.2 5107.0 5148.0 5153.1 5183.1 5854.5 5955.7 6001.6 6040.6 6109.9 5771.8 5925.6 5971.4 5975.6 5979.7 6068.1 6104.0 6130.4 6152.1 6159.9 5702.7 5760.1 5812.1 5854.9 5898.5 5876.1 5918.9 5931.8 5937.7 5946.8 5624.9 5766.0 5781.7 5784.3 5784.7 5688.8 5700.7 5710.6 5753.1 5800.0 5630.0 5634.6 5646.5 5655.1 5659.0 5619.0 5777.2 5793.4 5803.7 5812.0 5547.1 5569.4 5577.7 5612.2 5661.0 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48593.50 Median:391347.50 stddev:84185.51 (21.5%) stddev-sans-first:84344.39 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: Values: 548.7 586.7 606.5 618.7 621.5 37187.3 37997.8 38083.6 38084.6 38147.0 42168.0 42614.6 42686.8 42756.6 42941.6 8573.5 8662.5 8724.7 8746.9 8781.6 8521.9 8622.6 8647.0 8677.5 8685.6 8590.2 8622.2 8647.8 8694.7 8717.2 8603.9 8622.5 8649.6 8692.7 8699.0 8467.7 8574.4 8598.7 8608.6 8653.9 39344.2 39496.2 39695.8 39701.8 39923.4 3217.7 3261.9 3338.6 3400.1 3510.9 29477.0 30314.2 30326.1 30337.5 30769.7 3864.5 3995.2 4074.8 4116.8 4173.1 261988.0 264833.0 264845.0 265107.0 265388.0 57902.1 58064.7 58258.7 58400.4 58405.1 62547.7 62880.7 63085.0 68766.3 69569.0 13199.3 13230.9 13314.5 13318.6 13384.8 9558.8 9610.2 9615.7 9632.9 9671.0 20202.2 20271.7 20456.3 20481.9 20535.0 7772.7 8144.3 8144.4 8157.1 8191.2 923.3 935.6 986.6 998.4 1018.9 27945.7 27968.0 28061.9 28138.6 28325.9 1056.8 1060.3 1067.9 1101.8 1116.9 14847.4 16516.0 17287.4 17381.6 17410.7 386527.0 389248.0 391316.0 391379.0 392817.0 53802.5 54224.5 54573.2 54656.0 54675.5 1312.2 1332.5 1332.9 1343.5 1345.1 28301.3 29188.4 29503.4 29515.6 29869.7 43658.8 44332.0 44432.6 44437.8 44478.8 290095.0 292570.0 293586.0 293970.0 295875.0 31486.5 45149.3 45353.8 46037.3 46210.3 42213.8 42229.4 42389.0 42607.0 42835.4 35027.5 35212.7 35324.3 35345.6 35736.5 35232.5 35768.0 35821.3 36099.8 36172.3 35228.3 35270.5 35277.0 35673.1 35728.0 31452.2 32146.8 32496.0 32678.7 32745.2 24321.3 24433.5 24505.0 24822.4 24940.8 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,279 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27904.36 Median:362.63 stddev:82484.65 (22746.0%) stddev-sans-first:82690.10 06:05:05 INFO - 2015-12-17 06:05:05,280 DEBUG : BROWSER_OUTPUT: Values: 357.1 358.3 362.1 362.6 362.7 16626.8 17446.3 17866.4 18282.5 19064.0 14641.0 14728.1 14759.4 14815.9 14922.3 4617.6 4801.9 4802.6 4810.3 4820.0 4809.4 4812.0 4912.0 5408.5 5432.1 5143.8 5250.8 5360.5 5363.8 5370.6 5252.2 5264.4 5271.0 5286.6 5289.6 5106.2 5327.8 5342.1 5342.7 5348.7 12313.4 12530.8 15234.5 20570.6 20573.4 2054.9 2064.1 2124.7 2132.4 2282.3 9969.3 10776.9 12137.9 12829.5 13158.7 1820.2 1885.7 1894.1 1902.4 1937.4 59843.0 63250.7 63743.0 64548.4 64703.0 9994.9 10190.6 10297.7 10303.7 10331.3 13439.1 13624.9 13641.7 13646.8 13660.1 6959.3 7043.2 7060.4 7087.8 7093.5 6665.9 6680.0 6682.9 6702.4 6716.5 4430.8 4462.2 4477.7 4485.1 4512.5 1794.3 1840.6 1852.7 1875.0 1876.7 405.0 441.3 455.5 458.1 464.1 10434.7 10781.2 10991.3 11082.7 11186.6 448.1 460.5 462.7 465.2 485.3 9615.9 10145.9 10211.3 10249.8 10321.0 498350.0 500900.0 503106.0 506467.0 508077.0 82623.6 83270.6 83557.0 85441.6 85789.6 1150.6 1162.2 1164.7 1173.3 1185.1 15991.7 16082.9 16198.4 16267.5 16434.4 36241.0 36623.1 36903.6 38032.4 38633.0 47133.5 48200.3 49016.0 49175.8 53021.2 9338.3 9623.3 9626.8 9648.4 9685.8 17075.1 17614.9 17860.6 17925.6 18533.3 14501.2 14514.7 15023.4 15560.1 15575.8 13817.5 14155.9 14372.7 14403.8 14608.5 14007.8 14213.6 14596.8 15059.5 15115.7 9230.6 9304.3 9405.8 9482.7 9518.3 10133.2 10248.8 12611.4 14926.9 15311.1 06:05:05 INFO - 2015-12-17 06:05:05,280 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,280 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5310.48 Median:6372.12 stddev:2828.77 (44.4%) stddev-sans-first:2821.78 06:05:05 INFO - 2015-12-17 06:05:05,281 DEBUG : BROWSER_OUTPUT: Values: 1444.2 1705.9 1752.7 1756.3 1761.0 6790.4 7001.5 7439.4 7815.0 7842.8 7200.1 7316.5 7401.3 7416.7 7453.7 2056.4 2087.6 2097.1 2098.3 2100.9 2078.7 2088.8 2098.0 2168.4 2176.9 2093.2 2093.8 2109.0 2111.7 2124.9 2055.3 2060.1 2069.5 2069.9 2070.6 2062.6 2063.4 2085.7 2099.6 2102.0 7679.2 7717.7 7758.0 7768.5 7771.6 4465.2 4495.3 4532.9 4550.1 4552.2 2886.5 2916.7 2917.0 2926.9 2935.2 892.1 926.4 945.3 953.5 967.7 10713.6 10718.4 10742.5 10746.9 10762.9 4118.5 4149.3 4185.7 4188.0 4226.4 9153.9 9174.8 9215.5 9243.3 9253.2 4462.6 4469.5 4487.1 4492.5 4496.1 4038.0 4045.5 4065.0 4152.9 4161.3 3376.2 3392.3 3394.9 3410.5 3413.1 1046.1 1046.9 1049.8 1056.9 1059.0 1324.5 1326.1 1327.9 1339.1 1345.3 7344.6 7357.5 7440.1 7455.3 7470.8 463.4 471.7 493.6 498.1 498.5 5771.9 5785.6 5811.6 5822.9 5834.9 8921.3 9463.4 9468.9 9482.1 9506.1 9189.6 9215.1 9275.6 9308.3 9376.8 6792.3 6994.9 6995.2 6996.4 7064.3 7336.3 7361.1 7368.6 7415.2 7415.2 7611.2 7682.6 7875.2 7910.5 8027.3 7956.8 7957.4 7976.5 7997.7 8021.4 6345.1 6593.3 6732.7 6810.9 6876.3 7267.8 7310.6 7320.8 7325.1 7325.6 6648.6 6836.0 6875.2 6968.4 7029.1 6705.3 6724.1 6829.0 6833.3 6856.7 6787.2 6812.8 6832.9 6838.6 6883.3 6308.7 6367.6 6370.0 6371.0 6373.2 6324.5 6378.3 6381.2 6383.7 6425.6 06:05:05 INFO - 2015-12-17 06:05:05,281 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,281 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5603.12 Median:6391.23 stddev:1665.34 (26.1%) stddev-sans-first:1622.06 06:05:05 INFO - 2015-12-17 06:05:05,281 DEBUG : BROWSER_OUTPUT: Values: 317.0 329.1 337.9 339.4 342.7 6325.6 6338.0 6374.8 6407.4 6425.1 6215.9 6311.1 6314.4 6315.6 6326.5 4857.4 4858.8 4859.2 4866.4 4868.4 4834.3 4840.9 4842.8 4849.8 4858.3 4719.1 4771.7 4801.7 4814.9 4837.4 4784.3 4788.4 4805.8 4816.7 4818.4 4219.8 4230.2 4231.5 4231.6 4231.9 5932.7 5959.9 5987.5 5991.6 6006.6 5502.7 5669.4 5679.3 5679.6 5686.8 6690.6 6694.9 6703.9 6713.0 6717.4 4693.2 4700.7 4701.2 4702.7 4713.2 6823.2 6924.4 7006.9 7020.4 7021.8 4852.6 4858.3 4866.5 4866.6 4874.0 4918.5 4919.9 4925.4 4928.3 4928.9 5556.7 5645.2 5654.2 5664.5 5671.5 6730.5 6747.6 6772.2 6776.6 6785.8 1688.0 1720.9 1746.9 1747.2 1747.9 1155.6 1161.8 1183.6 1187.4 1192.8 6318.5 6386.4 6396.1 6401.5 6407.7 6791.4 6829.9 6860.1 6871.2 6879.1 6327.5 6413.0 6427.5 6431.3 6435.5 3742.7 3764.6 3768.2 3770.4 3770.7 7172.6 7175.2 7175.7 7178.3 7184.0 6807.7 6904.8 6953.7 6960.1 6986.7 7015.4 7052.9 7066.4 7081.9 7155.7 6813.6 6853.2 6865.8 6883.1 6896.9 6627.4 6786.3 6793.2 6809.4 6825.9 7152.4 7160.7 7162.5 7169.9 7174.0 4843.9 4845.3 4846.1 4854.2 4866.2 6748.6 6835.2 6847.3 6872.4 6879.5 6610.0 6645.1 6668.7 6676.0 6679.1 6653.0 6662.1 6663.7 6666.5 6679.1 6409.0 6532.3 6552.5 6552.9 6564.3 6695.1 6700.7 6704.3 6708.6 6710.3 6436.6 6496.8 6505.3 6523.0 6529.6 06:05:05 INFO - 2015-12-17 06:05:05,282 DEBUG : BROWSER_OUTPUT: 06:05:05 INFO - 2015-12-17 06:05:05,282 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13509.93 Median:47195.15 stddev:15690.98 (33.2%) stddev-sans-first:15705.62 06:05:05 INFO - 2015-12-17 06:05:05,283 DEBUG : BROWSER_OUTPUT: Values: 723.2 773.1 776.6 845.4 876.1 13023.2 13280.7 13292.9 13390.1 13410.6 11828.6 11878.9 11922.8 12329.3 12786.1 828.5 836.9 842.5 843.5 844.4 834.3 834.6 836.1 836.8 842.0 871.7 872.6 876.3 877.9 878.5 867.4 868.4 870.5 871.6 873.8 636.4 638.4 640.4 641.9 644.5 13547.0 13570.5 13573.5 13592.7 13599.7 11714.2 11760.1 11775.0 11862.8 11974.8 10289.4 10335.7 10357.3 10422.3 10464.7 3586.9 3633.9 3641.1 3689.6 3716.0 47886.8 47953.0 48027.3 48179.8 48244.0 9527.6 9913.6 10141.4 10216.7 10220.6 17245.3 17425.2 17436.9 17461.7 17471.8 6966.3 7061.5 7063.5 7065.8 7074.2 4149.9 4211.3 4286.8 4307.7 4309.5 3017.6 3018.8 3044.2 3053.4 3060.2 538.1 538.2 539.8 553.2 553.7 628.0 666.0 672.8 682.8 709.7 8554.7 8594.0 8771.2 8857.9 8918.6 568.0 678.0 693.9 704.4 731.0 4019.2 4140.2 4175.1 4215.2 4239.2 55562.4 55954.7 56241.4 56262.0 56515.0 50652.7 50661.5 51158.2 51465.2 51883.2 45264.0 45723.3 45870.3 46415.5 46503.5 8092.2 8188.4 8284.1 8294.4 8313.9 33722.8 34043.1 34321.1 34461.3 34603.3 40175.6 40362.4 44194.3 44353.3 44549.3 9502.1 9924.8 9971.2 10291.6 10394.2 11617.1 11626.5 11649.1 11857.1 11917.2 10923.9 11024.5 11115.8 11137.4 11452.1 10751.5 10866.7 10965.5 11086.1 11472.4 10474.6 10650.7 10792.0 10924.2 11008.2 9405.3 9446.2 9489.9 9775.0 9865.5 8886.8 8962.2 9038.0 9727.4 10162.4 06:05:05 INFO - 2015-12-17 06:05:05,283 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:05:05 INFO - 2015-12-17 06:05:05,283 DEBUG : BROWSER_OUTPUT: 06:05:06 INFO - 2015-12-17 06:05:06,713 INFO : Browser exited with error code: 0 06:05:06 INFO - 2015-12-17 06:05:06,734 INFO : Completed test dromaeo_css (00:19:21) 06:05:06 INFO - 2015-12-17 06:05:06,734 INFO : Starting test kraken 06:05:06 INFO - 2015-12-17 06:05:06,734 DEBUG : operating with platform_type : linux_ 06:05:06 INFO - 2015-12-17 06:05:06,734 INFO : Initialising browser for kraken test... 06:05:06 INFO - 2015-12-17 06:05:06,740 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv_m4Ob/profile http://localhost:58778/getInfo.html 06:05:21 INFO - 2015-12-17 06:05:21,433 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:05:21 INFO - 2015-12-17 06:05:21,433 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:05:21 INFO - 2015-12-17 06:05:21,433 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 06:05:21 INFO - 2015-12-17 06:05:21,433 DEBUG : BROWSER_OUTPUT: __metrics 06:05:21 INFO - 2015-12-17 06:05:21,988 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:05:22 INFO - 2015-12-17 06:05:22,791 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:05:27 INFO - 2015-12-17 06:05:27,237 INFO : Browser initialized. 06:05:27 INFO - 2015-12-17 06:05:27,237 INFO : Running cycle 1/1 for kraken test... 06:05:27 INFO - 2015-12-17 06:05:27,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv_m4Ob/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:05:39 INFO - 2015-12-17 06:05:39,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 143699968 06:05:39 INFO - 2015-12-17 06:05:39,113 DEBUG : BROWSER_OUTPUT: 06:05:41 INFO - 2015-12-17 06:05:41,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58778/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:42 INFO - 2015-12-17 06:05:42,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 144273408 06:05:42 INFO - 2015-12-17 06:05:42,193 DEBUG : BROWSER_OUTPUT: 06:05:44 INFO - 2015-12-17 06:05:44,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58778/tests/kraken/driver.html?testName=audio-dft) 06:05:45 INFO - 2015-12-17 06:05:45,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 144445440 06:05:45 INFO - 2015-12-17 06:05:45,457 DEBUG : BROWSER_OUTPUT: 06:05:48 INFO - 2015-12-17 06:05:48,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58778/tests/kraken/driver.html?testName=audio-fft) 06:05:48 INFO - 2015-12-17 06:05:48,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 06:05:48 INFO - 2015-12-17 06:05:48,911 DEBUG : BROWSER_OUTPUT: 06:05:50 INFO - 2015-12-17 06:05:50,870 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58778/tests/kraken/driver.html?testName=audio-oscillator) 06:05:51 INFO - 2015-12-17 06:05:51,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 06:05:51 INFO - 2015-12-17 06:05:51,451 DEBUG : BROWSER_OUTPUT: 06:05:53 INFO - 2015-12-17 06:05:53,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58778/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:54 INFO - 2015-12-17 06:05:54,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 06:05:54 INFO - 2015-12-17 06:05:54,218 DEBUG : BROWSER_OUTPUT: 06:05:57 INFO - 2015-12-17 06:05:57,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58778/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:57 INFO - 2015-12-17 06:05:57,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 06:05:57 INFO - 2015-12-17 06:05:57,756 DEBUG : BROWSER_OUTPUT: 06:06:01 INFO - 2015-12-17 06:06:01,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58778/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:01 INFO - 2015-12-17 06:06:01,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 139988992 06:06:01 INFO - 2015-12-17 06:06:01,744 DEBUG : BROWSER_OUTPUT: 06:06:04 INFO - 2015-12-17 06:06:04,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58778/tests/kraken/driver.html?testName=json-parse-financial) 06:06:05 INFO - 2015-12-17 06:06:05,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 140337152 06:06:05 INFO - 2015-12-17 06:06:05,128 DEBUG : BROWSER_OUTPUT: 06:06:06 INFO - 2015-12-17 06:06:06,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58778/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:07 INFO - 2015-12-17 06:06:07,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 06:06:07 INFO - 2015-12-17 06:06:07,297 DEBUG : BROWSER_OUTPUT: 06:06:09 INFO - 2015-12-17 06:06:09,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:09 INFO - 2015-12-17 06:06:09,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 140644352 06:06:09 INFO - 2015-12-17 06:06:09,717 DEBUG : BROWSER_OUTPUT: 06:06:11 INFO - 2015-12-17 06:06:11,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:12 INFO - 2015-12-17 06:06:12,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 140824576 06:06:12 INFO - 2015-12-17 06:06:12,410 DEBUG : BROWSER_OUTPUT: 06:06:14 INFO - 2015-12-17 06:06:14,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:15 INFO - 2015-12-17 06:06:15,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 141467648 06:06:15 INFO - 2015-12-17 06:06:15,459 DEBUG : BROWSER_OUTPUT: 06:06:18 INFO - 2015-12-17 06:06:18,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:18 INFO - 2015-12-17 06:06:18,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 142348288 06:06:18 INFO - 2015-12-17 06:06:18,976 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58778/tests/kraken/driver.html?testName=ai-astar) 06:06:20 INFO - 2015-12-17 06:06:20,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;111;111;110;122;110;110;110;110 06:06:20 INFO - 2015-12-17 06:06:20,929 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;127;152;159;126;161;156;130;170;132 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;163;164;163;160;163;171;165;163 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;78;71;145;71;77;71;72 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;142;92;93;93;133;92;93;131 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;109;110;109;110;110;110;110 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;149;146;146;147;146;147;146;146;145 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;96;96;95;97;96;96;96 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;61;61;60;61;66;65;60;68;60 06:06:20 INFO - 2015-12-17 06:06:20,930 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;67;68;68;68;68;68;69 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;87;88;85;86;85;85;86;95;85 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;136;118;126;122;117;121;115;124;124 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;156;155;154;153;144;161;153;159;141 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;71;68;67;72;67;71;68;71;67 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:06:20 INFO - 2015-12-17 06:06:20,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,713 06:06:20 INFO - 2015-12-17 06:06:20,932 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:06:20 INFO - 2015-12-17 06:06:20,932 DEBUG : BROWSER_OUTPUT: __startTimestamp1450361180923__endTimestamp 06:06:20 INFO - 2015-12-17 06:06:20,932 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:4.42 (4.0%) stddev-sans-first:4.68 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 111.0 111.0 110.0 122.0 110.0 110.0 110.0 110.0 06:06:20 INFO - 2015-12-17 06:06:20,933 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.80 Median:155.50 stddev:16.31 (10.5%) stddev-sans-first:17.03 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: Values: 155.0 127.0 152.0 159.0 126.0 161.0 156.0 130.0 170.0 132.0 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.81 (1.7%) stddev-sans-first:2.98 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 163.0 164.0 163.0 160.0 163.0 171.0 165.0 163.0 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:71.50 stddev:23.02 (32.2%) stddev-sans-first:24.19 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 78.0 71.0 145.0 71.0 77.0 71.0 72.0 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.50 stddev:20.78 (22.5%) stddev-sans-first:21.46 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 142.0 92.0 93.0 93.0 133.0 92.0 93.0 131.0 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,934 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: Values: 146.0 149.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 145.0 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:61.50 stddev:2.88 (4.7%) stddev-sans-first:3.05 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: Values: 62.0 61.0 61.0 60.0 61.0 66.0 65.0 60.0 68.0 60.0 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,935 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:3.44 (4.0%) stddev-sans-first:3.22 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: Values: 92.0 87.0 88.0 85.0 86.0 85.0 85.0 86.0 95.0 85.0 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.00 stddev:6.32 (5.1%) stddev-sans-first:6.21 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: Values: 115.0 136.0 118.0 126.0 122.0 117.0 121.0 115.0 124.0 124.0 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:154.50 stddev:6.41 (4.2%) stddev-sans-first:6.51 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: Values: 147.0 156.0 155.0 154.0 153.0 144.0 161.0 153.0 159.0 141.0 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:2.00 (2.9%) stddev-sans-first:2.09 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 68.0 67.0 72.0 67.0 71.0 68.0 71.0 67.0 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:06:20 INFO - 2015-12-17 06:06:20,936 DEBUG : BROWSER_OUTPUT: 06:06:22 INFO - 2015-12-17 06:06:22,365 INFO : Browser exited with error code: 0 06:06:22 INFO - 2015-12-17 06:06:22,414 INFO : Completed test kraken (00:01:15) 06:06:22 INFO - 2015-12-17 06:06:22,414 INFO : Starting test v8_7 06:06:22 INFO - 2015-12-17 06:06:22,414 DEBUG : operating with platform_type : linux_ 06:06:22 INFO - 2015-12-17 06:06:22,414 INFO : Initialising browser for v8_7 test... 06:06:22 INFO - 2015-12-17 06:06:22,420 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn3xcj2/profile http://localhost:58778/getInfo.html 06:06:37 INFO - 2015-12-17 06:06:37,232 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:06:37 INFO - 2015-12-17 06:06:37,232 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:06:37 INFO - 2015-12-17 06:06:37,232 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 06:06:37 INFO - 2015-12-17 06:06:37,232 DEBUG : BROWSER_OUTPUT: __metrics 06:06:37 INFO - 2015-12-17 06:06:37,954 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:06:38 INFO - 2015-12-17 06:06:38,495 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:06:41 INFO - 2015-12-17 06:06:41,965 INFO : Browser initialized. 06:06:41 INFO - 2015-12-17 06:06:41,965 INFO : Running cycle 1/1 for v8_7 test... 06:06:41 INFO - 2015-12-17 06:06:41,965 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn3xcj2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:06:53 INFO - 2015-12-17 06:06:53,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 143478784 06:06:53 INFO - 2015-12-17 06:06:53,779 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58778/tests/v8_7/run.html (next: http://localhost:58778/tests/v8_7/run.html) 06:07:15 INFO - 2015-12-17 06:07:15,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 138903552 06:07:15 INFO - 2015-12-17 06:07:15,426 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,427 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:07:15 INFO - 2015-12-17 06:07:15,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:07:15 INFO - 2015-12-17 06:07:15,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:07:15 INFO - 2015-12-17 06:07:15,427 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |0;Richards;165.6726308813784 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.09937888198758 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.2466836014677 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1075.268817204301 06:07:15 INFO - 2015-12-17 06:07:15,428 DEBUG : BROWSER_OUTPUT: |5;Earley;698.8120195667366 06:07:15 INFO - 2015-12-17 06:07:15,429 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 06:07:15 INFO - 2015-12-17 06:07:15,429 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 06:07:15 INFO - 2015-12-17 06:07:15,429 DEBUG : BROWSER_OUTPUT: |8;Splay;702.5892232330301 06:07:15 INFO - 2015-12-17 06:07:15,429 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:07:15 INFO - 2015-12-17 06:07:15,429 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:07:15 INFO - 2015-12-17 06:07:15,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1450361235426__endTimestamp 06:07:15 INFO - 2015-12-17 06:07:15,430 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,430 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:07:15 INFO - 2015-12-17 06:07:15,430 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.67 Median:165.67 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: Values: 165.7 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.10 Median:194.10 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: Values: 194.1 06:07:15 INFO - 2015-12-17 06:07:15,431 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,432 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.25 Median:282.25 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,432 DEBUG : BROWSER_OUTPUT: Values: 282.2 06:07:15 INFO - 2015-12-17 06:07:15,432 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,432 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,433 DEBUG : BROWSER_OUTPUT: Values: 5175.3 06:07:15 INFO - 2015-12-17 06:07:15,433 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,433 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,434 DEBUG : BROWSER_OUTPUT: Values: 1075.3 06:07:15 INFO - 2015-12-17 06:07:15,434 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,434 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:698.81 Median:698.81 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: Values: 698.8 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: Values: 12370.4 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,435 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: Values: 25225.0 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:702.59 Median:702.59 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: Values: 702.6 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:07:15 INFO - 2015-12-17 06:07:15,436 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:07:15 INFO - 2015-12-17 06:07:15,437 DEBUG : BROWSER_OUTPUT: 06:07:16 INFO - 2015-12-17 06:07:16,829 INFO : Browser exited with error code: 0 06:07:16 INFO - 2015-12-17 06:07:16,843 INFO : Completed test v8_7 (00:00:54) 06:07:17 INFO - 2015-12-17 06:07:17,084 INFO : Completed test suite (00:21:31) 06:07:17 INFO - 2015-12-17 06:07:17,084 DEBUG : Working with test: dromaeo_css 06:07:17 INFO - 2015-12-17 06:07:17,085 DEBUG : Generating results file: dromaeo_css 06:07:17 INFO - 2015-12-17 06:07:17,086 DEBUG : Working with test: kraken 06:07:17 INFO - 2015-12-17 06:07:17,086 DEBUG : Generating results file: kraken 06:07:17 INFO - 2015-12-17 06:07:17,086 INFO : javascript benchmark 06:07:17 INFO - 2015-12-17 06:07:17,086 DEBUG : Working with test: v8_7 06:07:17 INFO - 2015-12-17 06:07:17,086 DEBUG : Generating results file: v8_7 06:07:17 INFO - 2015-12-17 06:07:17,087 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:17 INFO - 2015-12-17 06:07:17,150 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:07:17 INFO - 2015-12-17 06:07:17,150 DEBUG : process_Request line: dromaeo_css 6960.31 graph.html#tests=[[72,1,43]] 06:07:17 INFO - 2015-12-17 06:07:17,150 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:17 INFO - 2015-12-17 06:07:17,181 DEBUG : process_Request line: kraken 1520.10 graph.html#tests=[[232,1,43]] 06:07:17 INFO - 2015-12-17 06:07:17,181 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:07:17 INFO - 2015-12-17 06:07:17,214 DEBUG : process_Request line: v8_7 21000.13 graph.html#tests=[[230,1,43]] 06:07:17 INFO - 2015-12-17 06:07:17,216 INFO : javascript benchmark 06:07:17 INFO - 2015-12-17 06:07:17,219 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.599050118735, 3253.934921301574, 3285.3429314137165, 3285.35935492579, 3290.4899740540195, 5260.079486089938, 5420.024395608789, 5459.972700136494, 5463.96184724903, 5471.6443431176995, 5383.300170977777, 5435.565154787618, 5459.563234941205, 5464.043792336335, 5473.2063850741615, 4915.877103072425, 4974.3533340665845, 5028.597712183035, 5063.873403164914, 5073.264376665381, 4974.577160941306, 5051.747412629372, 5065.848024559251, 5076.13705670037, 5149.17613181891, 4828.806847726087, 4921.163402221631, 4921.286413470027, 4941.901161976758, 5015.0, 4907.1657818171, 4947.925781113287, 4948.653594248404, 4951.950480495185, 4959.8016079356785, 4873.074115917964, 5003.424606170301, 5012.097822391968, 5033.421156567005, 5043.268726034741, 5155.40712818027, 5280.339957505312, 5285.577153827685, 5320.65415747979, 5353.170258609922, 5759.856003599902, 5794.768209271666, 5805.187273781674, 5813.912791308134, 5834.066549352084, 5786.739596718157, 5787.971060144714, 5789.536837053026, 5819.301683797971, 5839.9124013139835, 5327.493888080626, 5419.918701219485, 5429.891402171935, 5502.504774570308, 5620.241267428926, 5948.226730525004, 5956.583039187302, 5957.523398128139, 5962.433568810956, 5975.043992961106, 5713.942860571341, 5732.512736417451, 5759.971200143972, 5761.53907687384, 5770.596058275881, 5647.124695672095, 5718.199452076713, 5746.482816546531, 5752.769889204469, 5761.279840019997, 5734.254546908875, 5763.0, 5784.421557844182, 5792.594518383757, 5795.710214489259, 5683.54531637468, 5732.054211055212, 5752.137179423036, 5757.395473475309, 5767.538596912237, 4365.563443655673, 4386.342048692658, 4472.127935052634, 4486.1252055849445, 4509.481409637933, 4039.434479172918, 4043.251998380309, 4044.292248856438, 4049.9392509112386, 4083.1629515949157, 5658.462446067617, 5670.262865827416, 5671.631343962629, 5677.2619559457835, 5687.459691329317, 5789.478946894716, 5799.8550036249435, 5858.736356863951, 5945.197398351167, 5958.374370691015, 5618.775248990077, 5632.690202038927, 5639.6334238274385, 5674.375818659944, 5697.743601537941, 5089.211172268304, 5106.974465127651, 5148.0, 5153.123968925292, 5183.0670479314085, 5854.4730974212525, 5955.731992060368, 6001.639901605918, 6040.60736052164, 6109.877802443926, 5771.826845194651, 5925.585209035326, 5971.4327138921735, 5975.551833612583, 5979.701014949148, 6068.089786531879, 6103.969480152571, 6130.386961303834, 6152.077188421773, 6159.938400616115, 5702.714864256854, 5760.135979603093, 5812.099124635688, 5854.9121763174435, 5898.528117750656, 5876.147958546072, 5918.881622367615, 5931.792387266425, 5937.703114844327, 5946.762129514944, 5624.943750562606, 5766.019776637898, 5781.739821708117, 5784.2769653793275, 5784.652920824764, 5688.77244910199, 5700.714964251688, 5710.628809127394, 5753.1370294456165, 5800.042992906123, 5629.971850140723, 5634.605577609692, 5646.491815736604, 5655.123455864347, 5659.03796354629, 5618.971905140448, 5777.162311464898, 5793.391693872083, 5803.709814509173, 5812.0, 5547.11246200606, 5569.44305569456, 5577.693226872561, 5612.158176273591, 5660.971695141498], "unit": "score", "name": "dojo.html", "value": 5398.258643969651}, {"lowerIsBetter": false, "replicates": [548.6968449931413, 586.6597373523356, 606.5238787551773, 618.656645561713, 621.5307442880625, 37187.25625487488, 37997.81001094998, 38083.619163808355, 38084.61915380845, 38147.0, 42168.0, 42614.57385426153, 42686.7865660672, 42756.57243427565, 42941.570584294146, 8573.52845593492, 8662.52356120413, 8724.738257852274, 8746.86879696805, 8781.604827782734, 8521.872171917426, 8622.568871556397, 8647.0, 8677.522736249504, 8685.609147588342, 8590.153117079826, 8622.223999840013, 8647.783805404852, 8694.652213911437, 8717.215450609443, 8603.870941935844, 8622.525761083138, 8649.567521623894, 8692.652293908268, 8699.0, 8467.66129354825, 8574.399792014561, 8598.742037738877, 8608.612612432393, 8653.870191947126, 39344.21311573781, 39496.21007579832, 39695.8015209925, 39701.80149099265, 39923.40114898279, 3217.7104060634656, 3261.9347613047844, 3338.6160591532043, 3400.0649821299094, 3510.8771193008124, 29477.0, 30314.242143946358, 30326.090217293517, 30337.544936825965, 30769.692303076907, 3864.536255649312, 3995.200959808021, 4074.816633251481, 4116.773577453238, 4173.123644034757, 261988.0, 264833.0, 264845.0, 265107.0, 265388.0, 57902.13146802801, 58064.70967645135, 58258.708706457044, 58400.41599584035, 58405.12392314119, 62547.68726156431, 62880.685596571726, 63085.0, 68766.31233687699, 69569.0, 13199.340032998312, 13230.867691323156, 13314.467421303234, 13318.600441986757, 13384.799228011587, 9558.761030974281, 9610.183134433511, 9615.653808466821, 9632.9036709632, 9670.951645241728, 20202.191912323637, 20271.695924561143, 20456.284030059174, 20481.89759051195, 20535.0, 7772.727954521678, 8144.348452123816, 8144.389170812095, 8157.14349993254, 8191.221833925768, 923.2533213689221, 935.6444551070686, 986.5954958466995, 998.3859926145368, 1018.9439580822977, 27945.668421394716, 27968.0, 28061.859690701825, 28138.577921331198, 28325.858370708014, 1056.8203405421098, 1060.2525219720078, 1067.8665166854144, 1101.8347247912877, 1116.8715597706205, 14847.406103755944, 16516.0, 17287.394941176997, 17381.565460863327, 17410.65178696419, 386527.0, 389248.0, 391316.0, 391379.0, 392817.0, 53802.461975379745, 54224.45775542194, 54573.181402279, 54656.0, 54675.453245467834, 1312.1667740984353, 1332.460353556811, 1332.8600496947874, 1343.4760443427072, 1345.051738524338, 28301.292467688472, 29188.416231674822, 29503.409931800816, 29515.55726664059, 29869.70130298669, 43658.781706091264, 44332.0, 44432.55567444284, 44437.77781111074, 44478.77760611176, 290095.0, 292570.0, 293586.0, 293970.0, 295875.0, 31486.52770208403, 45149.322760157964, 45353.77323113364, 46037.309440359095, 46210.306845398016, 42213.78893105515, 42229.36655950102, 42389.0, 42607.0, 42835.357469637354, 35027.47458788171, 35212.67748024071, 35324.29351412906, 35345.64654353423, 35736.463953041246, 35232.471512926815, 35768.0, 35821.28357432889, 36099.819500902326, 36172.27655446929, 35228.295434091684, 35270.47094293639, 35277.0, 35673.1081722959, 35728.0, 31452.213694657818, 32146.839265803523, 32496.02511924646, 32678.673213267564, 32745.18137046593, 24321.270361889172, 24433.51132977366, 24505.0, 24822.37944051341, 24940.75059249457], "unit": "score", "name": "ext.html", "value": 18646.46652954034}, {"lowerIsBetter": false, "replicates": [357.12148115635534, 358.32455820777824, 362.069481432718, 362.55586906040105, 362.7098321342926, 16626.75059874103, 17446.30214791407, 17866.374676886313, 18282.451526454228, 19064.0, 14641.0, 14728.116313021226, 14759.409623615069, 14815.925920370382, 14922.253887305646, 4617.60750336221, 4801.879953001168, 4802.567768900798, 4810.326554282386, 4820.035992801436, 4809.422869255694, 4811.951880481185, 4912.0, 5408.540274076709, 5432.076546987022, 5143.768530416121, 5250.842474725764, 5360.490753378423, 5363.785448582052, 5370.624056316059, 5252.159654455307, 5264.394594621629, 5271.0, 5286.629935904508, 5289.629725919187, 5106.208537676666, 5327.813526526592, 5342.065138600729, 5342.732863356856, 5348.679079255257, 12313.384330783425, 12530.81203781944, 15234.466793662168, 20570.5885882283, 20573.382798516068, 2054.8869812160324, 2064.060852312194, 2124.7237859078377, 2132.3709505695856, 2282.3038973113194, 9969.302148849583, 10776.946115269451, 12137.878621213764, 12829.486820527261, 13158.736825263537, 1820.2082094289026, 1885.70771530413, 1894.062439092658, 1902.4102528216158, 1937.3800383877165, 59843.0, 63250.68374658097, 63743.0, 64548.354516455176, 64703.0, 9994.850077248848, 10190.643327483502, 10297.691069267934, 10303.742406439898, 10331.276810623183, 13439.126456780277, 13624.86375136236, 13641.727165456636, 13646.795298070538, 13660.112092713942, 6959.304069593, 7043.225245223021, 7060.364567188978, 7087.751928682472, 7093.503454758117, 6665.866682666319, 6680.031395447633, 6682.9331706682315, 6702.36327548882, 6716.529842910949, 4430.8449204277695, 4462.241418958784, 4477.686561940698, 4485.058137791035, 4512.548745125527, 1794.3271273272524, 1840.6226723521645, 1852.740616313717, 1875.0, 1876.718492226177, 405.0178317579916, 441.2785096367462, 455.462554186057, 458.0861181942047, 464.09733069180123, 10434.739131521621, 10781.191410644233, 10991.285566438157, 11082.667519974413, 11186.608468703556, 448.13733562891304, 460.4589607211513, 462.6853739457134, 465.2277219815091, 485.3011663204974, 9615.9038409615, 10145.898541014643, 10211.336263142872, 10249.795004099877, 10321.0, 498350.0, 500900.0, 503106.0, 506467.0, 508077.0, 82623.58688206521, 83270.58364708138, 83557.0, 85441.57279213688, 85789.57105214434, 1150.5915400033034, 1162.2155045344527, 1164.7204670878928, 1173.266708307308, 1185.0993245133761, 15991.68016639684, 16082.919585401998, 16198.352065917232, 16267.51197464078, 16434.424795132112, 36241.0, 36623.08442288964, 36903.63096369002, 38032.429513556766, 38633.0, 47133.528664714286, 48200.27699584439, 49016.0, 49175.75412122916, 53021.204681930576, 9338.299627528098, 9623.326367154232, 9626.759331016781, 9648.372855764354, 9685.757856053655, 17075.146242688064, 17614.91192544029, 17860.642787144443, 17925.551861203574, 18533.258669653063, 14501.20243386624, 14514.709705806035, 15023.399064037316, 15560.144192069092, 15575.766363504783, 13817.516386926409, 14155.929220353832, 14372.712545749235, 14403.78394324065, 14608.488702895773, 14007.789883151558, 14213.644658883197, 14596.781048284496, 15059.472918447802, 15115.697686045998, 9230.630774768933, 9304.30217733659, 9405.81188376215, 9482.668106616235, 9518.286128540249, 10133.18934485254, 10248.846267306146, 12611.36943152857, 14926.850731492546, 15311.081335119929], "unit": "score", "name": "jquery.html", "value": 8405.468347832122}, {"lowerIsBetter": false, "replicates": [1444.234555685487, 1705.8550023248026, 1752.6669932712784, 1756.3325936144263, 1761.040233072975, 6790.354916282945, 7001.509894307401, 7439.442041846863, 7814.960925195373, 7842.843143137134, 7200.063991681074, 7316.451266155046, 7401.296876796696, 7416.703331866733, 7453.701851925916, 2056.424201223656, 2087.6451003329394, 2097.1087287902656, 2098.2760947473175, 2100.8634438761433, 2078.7089807426973, 2088.812006919377, 2098.03490394418, 2168.403688985534, 2176.934691959236, 2093.173196587347, 2093.822025127866, 2108.968365474519, 2111.7043613894066, 2124.9043793029273, 2055.342290467051, 2060.103854823149, 2069.503319203388, 2069.8965051747505, 2070.6169358668694, 2062.577171679817, 2063.4428704249917, 2085.6558667819945, 2099.5695882344235, 2101.95796084079, 7679.232076792332, 7717.65270562826, 7757.961210193969, 7768.53388796674, 7771.572563509005, 4465.196264672358, 4495.280755079171, 4532.9320060199125, 4550.067236216601, 4552.248878934972, 2886.5381538953666, 2916.6500019997734, 2917.0, 2926.926826829325, 2935.2074939766358, 892.067789160329, 926.4070994563485, 945.3099237556553, 953.5327689432198, 967.6564819489121, 10713.625023124154, 10718.410487423189, 10742.516586753614, 10746.946265268623, 10762.892371076345, 4118.5263694674895, 4149.294619914562, 4185.748855068706, 4188.0, 4226.36604509326, 9153.908460915438, 9174.816503670023, 9215.53922303882, 9243.26053915685, 9253.213476854542, 4462.642988560908, 4469.4860091089295, 4487.125010622897, 4492.460904691393, 4496.123255965055, 4038.0, 4045.4538637284177, 4065.0, 4152.875413737593, 4161.292580261363, 3376.1559610097474, 3392.2876195999115, 3394.9151271218416, 3410.471376936579, 3413.0955296846355, 1046.100353695821, 1046.947652617366, 1049.8057859296055, 1056.8731752189785, 1058.9788204236027, 1324.5099313254157, 1326.0783755290174, 1327.9402426890813, 1339.055965544289, 1345.3407830163346, 7344.596047217347, 7357.5217610855125, 7440.10718713747, 7455.254474552501, 7470.813229669302, 463.4484962894145, 471.7146126593362, 493.575525048458, 498.05866911537225, 498.4990084964587, 5771.94228057714, 5785.566082543826, 5811.622244554091, 5822.941770582324, 5834.912476312858, 8921.286297096216, 9463.43219406824, 9468.90531094694, 9482.099200576073, 9506.096920792514, 9189.632414703337, 9215.124563166488, 9275.628974841065, 9308.301877359225, 9376.765580860532, 6792.320767923267, 6994.860102797916, 6995.1955525114245, 6996.405305549085, 7064.32888875556, 7336.266373362621, 7361.1166659999, 7368.59472729005, 7415.184329723618, 7415.184329723834, 7611.162772094955, 7682.577458239851, 7875.212478752079, 7910.52536847791, 8027.317677997436, 7956.84086318282, 7957.403194760301, 7976.481528700848, 7997.720079797179, 8021.398395120273, 6345.111684364285, 6593.307702691341, 6732.697028633821, 6810.897836532555, 6876.277990810893, 7267.7819665410125, 7310.634468276458, 7320.780376588711, 7325.120985481776, 7325.597092159769, 6648.601083934979, 6836.0, 6875.243723190345, 6968.407685346802, 7029.0862187915245, 6705.295943926013, 6724.058631791651, 6829.043933849364, 6833.3166683331265, 6856.657167141523, 6787.185537735306, 6812.795616131524, 6832.863342733217, 6838.623875686686, 6883.3116688330765, 6308.684565771601, 6367.554271200971, 6369.9681501592195, 6371.044343348535, 6373.203349581302, 6324.462420694293, 6378.298387177314, 6381.202349706286, 6383.744650213939, 6425.58233714807], "unit": "score", "name": "mootools.html", "value": 4262.518140074524}, {"lowerIsBetter": false, "replicates": [316.9572107765451, 329.1130403562399, 337.94086034943876, 339.3619994410508, 342.6795945790684, 6325.557210995232, 6338.0, 6374.840628984278, 6407.359264073591, 6425.100485931974, 6215.875682486348, 6311.116443697886, 6314.368563143684, 6315.589486683362, 6326.525510586713, 4857.392825896763, 4858.82994095205, 4859.2225243960975, 4866.391701037371, 4868.367112275399, 4834.2990266411525, 4840.854774356757, 4842.806287748504, 4849.830255941043, 4858.295547145662, 4719.056188762244, 4771.665983381165, 4801.68789028712, 4814.855554333358, 4837.371141751585, 4784.330193772875, 4788.449328327235, 4805.783739731721, 4816.7350795706225, 4818.397700287464, 4219.810108545123, 4230.238557059728, 4231.513375961773, 4231.576842315774, 4231.87304380869, 5932.7330270137945, 5959.940400595982, 5987.491063259585, 5991.580589358747, 6006.579539432241, 5502.734371094671, 5669.433056694339, 5679.346875109374, 5679.574031947621, 5686.800961966353, 6690.565113267622, 6694.899576506356, 6703.865922681519, 6713.0, 6717.395434410926, 4693.225617773063, 4700.741459219742, 4701.224297990828, 4702.694324868872, 4713.151632706112, 6823.215330236987, 6924.4114250288785, 7006.859862802716, 7020.368166865007, 7021.82445438863, 4852.56326930578, 4858.3441235432765, 4866.513348665176, 4866.635002374836, 4873.95126048735, 4918.532739389752, 4919.917618124007, 4925.38432695913, 4928.334674818925, 4928.901421971541, 5556.666600004012, 5645.181448689917, 5654.208410822488, 5664.54683625309, 5671.51792097668, 6730.461563074942, 6747.595144291358, 6772.187337519431, 6776.627285499345, 6785.830354241183, 1687.957801054959, 1720.9483715488554, 1746.938857139994, 1747.1788259518007, 1747.9213435395438, 1155.5608868629868, 1161.8315344275034, 1183.627157445402, 1187.3766272706898, 1192.8210768384638, 6318.494520438354, 6386.393292637192, 6396.0725694774, 6401.455876250478, 6407.7436902524305, 6791.422729068085, 6829.93170068293, 6860.108185935796, 6871.244163142051, 6879.140107486564, 6327.462165715873, 6412.97392417211, 6427.517936154807, 6431.324710905381, 6435.517336199804, 3742.719296052807, 3764.5670747863796, 3768.2275133597545, 3770.4344348347418, 3770.6606405423645, 7172.641367931583, 7175.246599107123, 7175.712971481186, 7178.318059784312, 7183.96408017967, 6807.727690892408, 6904.827379315558, 6953.687084081127, 6960.095187625678, 6986.685599148051, 7015.403690686247, 7052.858942821114, 7066.434685225273, 7081.929180708127, 7155.713771449188, 6813.557118787263, 6853.246142924374, 6865.759698410531, 6883.070785443901, 6896.93103068983, 6627.403533681992, 6786.253512113763, 6793.184817821893, 6809.421199198124, 6825.863482730417, 7152.392046676091, 7160.713571457083, 7162.531681005277, 7169.856602868018, 7174.0, 4843.927341089957, 4845.297431872429, 4846.103470857903, 4854.2233242681, 4866.221404575251, 6748.561343512656, 6835.179778426621, 6847.281035491202, 6872.41584465326, 6879.484038697017, 6609.966950165219, 6645.102911107132, 6668.699908504226, 6675.9666201670625, 6679.131712877295, 6653.035309880137, 6662.100616416916, 6663.7001334941015, 6666.533342665967, 6679.0649309097735, 6409.038644203407, 6532.346765323429, 6552.508561857784, 6552.868942621216, 6564.310747371457, 6695.12963314766, 6700.731970721116, 6704.296048914989, 6708.597484150967, 6710.328967103251, 6436.645984470899, 6496.7726129585235, 6505.251896032017, 6523.021546768023, 6529.608223506605], "unit": "score", "name": "prototype.html", "value": 5056.241858624396}, {"lowerIsBetter": false, "replicates": [723.1755798389834, 773.1379511844292, 776.5961699916043, 845.4124383553429, 876.0801158783278, 13023.218606883582, 13280.734385312287, 13292.933535332333, 13390.062695611312, 13410.597682069541, 11828.645140645795, 11878.940605296983, 11922.761544769099, 12329.321887296195, 12786.104972651918, 828.4780588229407, 836.8619177835665, 842.5323945210406, 843.5402705525503, 844.3667249562828, 834.3116928533954, 834.5743670727942, 836.1304243586662, 836.8284501677172, 841.9938173882214, 871.6818361298112, 872.6334939325467, 876.2508055612456, 877.868319752036, 878.5299864572455, 867.41449521573, 868.3704314372061, 870.4951128345544, 871.6339137562176, 873.8470767615642, 636.4272155060436, 638.4222278837659, 640.4140211706283, 641.9486441084701, 644.4876323322923, 13547.0, 13570.45718171272, 13573.52492662752, 13592.660183495393, 13599.728005439934, 11714.180007399485, 11760.117991150699, 11775.0, 11862.762744745056, 11974.760504789943, 10289.434081125535, 10335.741606459824, 10357.274990750651, 10422.322549034365, 10464.738381540446, 3586.910327241814, 3633.94549081764, 3641.0715267606856, 3689.594144644087, 3715.981420092909, 47886.76056619729, 47953.04093918137, 48027.27959080617, 48179.75910120462, 48243.99999999965, 9527.618895244252, 9913.603455861685, 10141.442220677785, 10216.693499195037, 10220.6422775204, 17245.310187592357, 17425.215865286093, 17436.91281543584, 17461.65076698459, 17471.825281747275, 6966.303369663095, 7061.505694601328, 7063.470239732041, 7065.752698655625, 7074.186468556079, 4149.875503734893, 4211.305134652748, 4286.7856607169515, 4307.676924230633, 4309.525952145262, 3017.5775391445213, 3018.83396413195, 3044.1628552148336, 3053.3740583180393, 3060.1890499017777, 538.0637690418722, 538.2276433318201, 539.7894821019805, 553.1923391847947, 553.7314402514777, 627.9528439209344, 666.0342503370133, 672.7981605518324, 682.8327059870363, 709.7054722290192, 8554.700585479479, 8593.95703021481, 8771.16673915977, 8857.911420885837, 8918.643254269757, 567.9744411501492, 677.993220067793, 693.931345727584, 704.3871831506622, 731.0313834169747, 4019.196160767858, 4140.192662430857, 4175.081482074, 4215.241256573785, 4239.236937351245, 55562.44437555654, 55954.72022639942, 56241.43758562362, 56262.0, 56515.0, 50652.74673626682, 50661.49338506642, 51158.23262651063, 51465.22802157971, 51883.22175167376, 45264.0, 45723.31415028777, 45870.31194532085, 46415.535844641796, 46503.5349646506, 8092.190780921861, 8188.385871059575, 8284.08875023759, 8294.377921656021, 8313.915277528818, 33722.83138584292, 34043.14892127617, 34321.14197145091, 34461.31077378388, 34603.30793384169, 40175.59824401836, 40362.394564080976, 44194.337084944396, 44353.33469997888, 44549.33176002427, 9502.140526300065, 9924.751881203028, 9971.152452041657, 10291.639792607222, 10394.168466522811, 11617.128715346214, 11626.476808543466, 11649.126315526539, 11857.110716696456, 11917.22538035025, 10923.945380273048, 11024.519864759257, 11115.83326250123, 11137.443127843737, 11452.083833293484, 10751.462426878468, 10866.67399978002, 10965.451727413756, 11086.057685096857, 11472.369019703996, 10474.581016759244, 10650.73373165677, 10792.0, 10924.18068644839, 11008.229423940247, 9405.294602904947, 9446.197073248852, 9489.85765213536, 9775.014742481528, 9865.506724663881, 8886.777830554287, 8962.238209752244, 9037.954810225907, 9727.367721098106, 10162.441065741456], "unit": "score", "name": "yui.html", "value": 6234.849575069806}], "name": "dromaeo_css", "value": 6960.307796713642}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 111.0, 111.0, 110.0, 122.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 152.0, 159.0, 126.0, 161.0, 156.0, 130.0, 170.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 163.0, 160.0, 163.0, 171.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 78.0, 71.0, 145.0, 71.0, 77.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 142.0, 92.0, 93.0, 93.0, 133.0, 92.0, 93.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 60.0, 61.0, 66.0, 65.0, 60.0, 68.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 62.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [92.0, 87.0, 88.0, 85.0, 86.0, 85.0, 85.0, 86.0, 95.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [115.0, 136.0, 118.0, 126.0, 122.0, 117.0, 121.0, 115.0, 124.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [147.0, 156.0, 155.0, 154.0, 153.0, 144.0, 161.0, 153.0, 159.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.3}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 67.0, 72.0, 67.0, 71.0, 68.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1520.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.6726308813784], "unit": "score", "name": "Richards", "value": 213.0828719999999}, {"lowerIsBetter": false, "replicates": [194.09937888198758], "unit": "score", "name": "DeltaBlue", "value": 340.63993600000003}, {"lowerIsBetter": false, "replicates": [282.2466836014677], "unit": "score", "name": "Encrypt", "value": 943.0792829999996}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [698.8120195667366], "unit": "score", "name": "Earley", "value": 953.7085530000003}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [702.5892232330301], "unit": "score", "name": "Splay", "value": 115.98669223107571}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21000.12986868201}]} 06:07:17 INFO - RETURN: dromaeo_css: 6960.31 06:07:17 INFO - RETURN: kraken: 1520.10 06:07:17 INFO - RETURN: v8_7: 21000.13 06:07:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21000.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1520.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6960.31"}}} 06:07:17 INFO - Return code: 0 06:07:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:07:17 INFO - # TBPL SUCCESS # 06:07:17 INFO - Running post-action listener: _resource_record_post_action 06:07:17 INFO - Running post-run listener: _resource_record_post_run 06:07:18 INFO - Total resource usage - Wall time: 1311s; CPU: 14.0%; Read bytes: 24576; Write bytes: 512741376; Read time: 5080; Write time: 5203360 06:07:18 INFO - install - Wall time: 19s; CPU: 26.0%; Read bytes: 0; Write bytes: 147406848; Read time: 0; Write time: 2299176 06:07:18 INFO - run-tests - Wall time: 1293s; CPU: 13.0%; Read bytes: 24576; Write bytes: 347877376; Read time: 5080; Write time: 2812964 06:07:18 INFO - Running post-run listener: _upload_blobber_files 06:07:18 INFO - Blob upload gear active. 06:07:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:07:18 INFO - Copying logs to upload dir... 06:07:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1357.590011 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2015-12-17 06:07:18.133358) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:07:18.136417) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/s6tD74bXTtGVEjnV-NbJWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:07:18.186491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:07:18.186789) ========= 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=256b35f542ca8bede9e27f1f00000291-1450356009.878842-565135829 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:07:18.236620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 06:07:18.236913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 06:07:18.237197) ========= ========= Total master_lag: 0.23 =========