builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1450364018.54 results: success (0) buildid: 20151217043003 builduid: 9c1cd80b90da4ef69dbbc4e2d742570f revision: f143af51f6e35932927b8ccac2509facbbe7b539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.539896) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.540551) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.540897) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006326 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.597441) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.597774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.667339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.667683) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.728957) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.729274) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.729666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.729966) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 06:53:38-- 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% 222M=0s 2015-12-17 06:53:39 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.938164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.938481) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.988765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 06:53:38.989151) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 06:53:39,180 truncating revision to first 12 chars 2015-12-17 06:53:39,181 Setting DEBUG logging. 2015-12-17 06:53:39,181 attempt 1/10 2015-12-17 06:53:39,181 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 06:53:39,432 unpacking tar archive at: mozilla-central-f143af51f6e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540196 ========= master_lag: 0.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 06:53:40.033316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:40.033587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:40.058889) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:40.059190) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:40.059624) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-17 06:53:40.059912) ========= /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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:40 INFO - MultiFileLogger online at 20151217 06:53:40 in /builds/slave/test-pgo 06:53:40 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 06:53:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:53:40 INFO - {'append_to_log': False, 06:53:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:53:40 INFO - 'blob_upload_branch': 'Firefox', 06:53:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:53:40 INFO - 'branch': 'Firefox', 06:53:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:40 INFO - 'config_files': ('talos/linux_config.py',), 06:53:40 INFO - 'default_actions': ('clobber', 06:53:40 INFO - 'read-buildbot-config', 06:53:40 INFO - 'download-and-extract', 06:53:40 INFO - 'populate-webroot', 06:53:40 INFO - 'create-virtualenv', 06:53:40 INFO - 'install', 06:53:40 INFO - 'run-tests'), 06:53:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:40 INFO - 'download_minidump_stackwalk': True, 06:53:40 INFO - 'download_symbols': 'ondemand', 06:53:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:40 INFO - 'installer_path': 'installer.exe', 06:53:40 INFO - 'log_level': 'info', 06:53:40 INFO - 'log_name': 'talos', 06:53:40 INFO - 'log_to_console': True, 06:53:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:40 INFO - 'opt_config_files': (), 06:53:40 INFO - 'pip_index': False, 06:53:40 INFO - 'sps_profile': False, 06:53:40 INFO - 'sps_profile_interval': 0, 06:53:40 INFO - 'suite': 'dromaeojs-e10s', 06:53:40 INFO - 'system_bits': '64', 06:53:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:40 INFO - 'title': 'talos-linux64-ix-058', 06:53:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:40 INFO - 'use_talos_json': True, 06:53:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:53:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:40 INFO - 'work_dir': 'build'} 06:53:40 INFO - ##### 06:53:40 INFO - ##### Running clobber step. 06:53:40 INFO - ##### 06:53:40 INFO - Running pre-action listener: _resource_record_pre_action 06:53:40 INFO - Running main action method: clobber 06:53:40 INFO - rmtree: /builds/slave/test-pgo/build 06:53:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:53:40 INFO - Running post-action listener: _resource_record_post_action 06:53:40 INFO - ##### 06:53:40 INFO - ##### Running read-buildbot-config step. 06:53:40 INFO - ##### 06:53:40 INFO - Running pre-action listener: _resource_record_pre_action 06:53:40 INFO - Running main action method: read_buildbot_config 06:53:40 INFO - Using buildbot properties: 06:53:40 INFO - { 06:53:40 INFO - "project": "", 06:53:40 INFO - "product": "firefox", 06:53:40 INFO - "script_repo_revision": "production", 06:53:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:53:40 INFO - "repository": "", 06:53:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 06:53:40 INFO - "buildid": "20151217043003", 06:53:40 INFO - "pgo_build": "True", 06:53:40 INFO - "basedir": "/builds/slave/test-pgo", 06:53:40 INFO - "buildnumber": 582, 06:53:40 INFO - "slavename": "talos-linux64-ix-058", 06:53:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:53:40 INFO - "platform": "ubuntu64_hw", 06:53:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:53:40 INFO - "branch": "mozilla-central", 06:53:40 INFO - "repo_path": "mozilla-central", 06:53:40 INFO - "revision": "f143af51f6e35932927b8ccac2509facbbe7b539", 06:53:40 INFO - "stage_platform": "linux64-pgo", 06:53:40 INFO - "builduid": "9c1cd80b90da4ef69dbbc4e2d742570f", 06:53:40 INFO - "slavebuilddir": "test" 06:53:40 INFO - } 06:53:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:53:40 INFO - Running post-action listener: _resource_record_post_action 06:53:40 INFO - ##### 06:53:40 INFO - ##### Running download-and-extract step. 06:53:40 INFO - ##### 06:53:40 INFO - Running pre-action listener: _resource_record_pre_action 06:53:40 INFO - Running main action method: download_and_extract 06:53:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:40 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json 06:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json 06:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:53:50 INFO - Downloaded 1302 bytes. 06:53:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:53:50 INFO - Using the following test package requirements: 06:53:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'jsshell-linux-x86_64.zip'], 06:53:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:53:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:53:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:50 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')]} 06:53:50 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:53:59 INFO - Downloaded 23117861 bytes. 06:53:59 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 06:53:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:59 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 06:54:00 INFO - Return code: 0 06:54:00 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 06:54: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')]} 06:54:00 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:54:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:54:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:54:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:01 INFO - Downloaded 23117861 bytes. 06:54:01 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 06:54:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:54:01 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 06:54:02 INFO - Return code: 0 06:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:02 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:04 INFO - Downloaded 11132052 bytes. 06:54:04 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 06:54:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:54:04 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 06:54:04 INFO - Return code: 0 06:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:04 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:54:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:54:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:54:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 06:54:05 INFO - Downloaded 59290131 bytes. 06:54:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:54:05 INFO - mkdir: /builds/slave/test-pgo/properties 06:54:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:54:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:54:05 INFO - Contents: 06:54:05 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:54:05 INFO - Running post-action listener: _resource_record_post_action 06:54:05 INFO - Running post-action listener: set_extra_try_arguments 06:54:05 INFO - ##### 06:54:05 INFO - ##### Running populate-webroot step. 06:54:05 INFO - ##### 06:54:05 INFO - Running pre-action listener: _resource_record_pre_action 06:54:05 INFO - Running main action method: populate_webroot 06:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:06 INFO - '--tppagecycles', 06:54:06 INFO - '7'], 06:54:06 INFO - 'tests': ['tsvgm']}}, 06:54:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:54:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:54:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:54:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'tests': ['damp', 'tps']}, 06:54:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['damp', 'tps']}, 06:54:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:54:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:54:06 INFO - 'other': {'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'other_l64': {'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'other_nol64': {'tests': ['a11yr', 06:54:06 INFO - 'ts_paint', 06:54:06 INFO - 'tpaint', 06:54:06 INFO - 'sessionrestore', 06:54:06 INFO - 'sessionrestore_no_auto_restore']}, 06:54:06 INFO - 'svgr': {'tests': ['tsvgx', 06:54:06 INFO - 'tsvgr_opacity', 06:54:06 INFO - 'tart', 06:54:06 INFO - 'tscrollx', 06:54:06 INFO - 'cart']}, 06:54:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['tsvgx', 06:54:06 INFO - 'tsvgr_opacity', 06:54:06 INFO - 'tart', 06:54:06 INFO - 'tscrollx', 06:54:06 INFO - 'cart']}, 06:54:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'tests': ['tp5o']}, 06:54:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'talos_options': ['--e10s'], 06:54:06 INFO - 'tests': ['tp5o']}, 06:54:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'talos_options': ['--xperf_path', 06:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:06 INFO - 'tests': ['tp5n']}, 06:54:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:06 INFO - 'talos_options': ['--e10s', 06:54:06 INFO - '--xperf_path', 06:54:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:06 INFO - 'tests': ['tp5n']}}, 06:54:06 INFO - 'talos.zip': {'path': '', 06:54:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:06 INFO - Running post-action listener: _resource_record_post_action 06:54:06 INFO - ##### 06:54:06 INFO - ##### Running create-virtualenv step. 06:54:06 INFO - ##### 06:54:06 INFO - Running pre-action listener: _resource_record_pre_action 06:54:06 INFO - Running main action method: create_virtualenv 06:54:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:54:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:54:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:54:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:06 INFO - Using real prefix '/usr' 06:54:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:08 INFO - Installing pip.................done. 06:54:08 INFO - Return code: 0 06:54:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:54: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')]} 06:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:08 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:08 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 06:54:08 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 06:54:08 INFO - Using env: {'DISPLAY': ':0', 06:54:08 INFO - 'HOME': '/home/cltbld', 06:54:08 INFO - 'LANG': 'en_US.UTF-8', 06:54:08 INFO - 'LANGUAGE': 'en_US:en', 06:54:08 INFO - 'LOGNAME': 'cltbld', 06:54:08 INFO - 'MAIL': '/var/mail/cltbld', 06:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:08 INFO - 'MOZ_NO_REMOTE': '1', 06:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:08 INFO - 'NO_EM_RESTART': '1', 06:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:08 INFO - 'SHELL': '/bin/bash', 06:54:08 INFO - 'SHLVL': '1', 06:54:08 INFO - 'TERM': 'linux', 06:54:08 INFO - 'TMOUT': '86400', 06:54:08 INFO - 'USER': 'cltbld', 06:54:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:08 INFO - '_': '/tools/buildbot/bin/python'} 06:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:08 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 06:54:08 INFO - Cleaning up... 06:54:08 INFO - Return code: 0 06:54:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:54: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')]} 06:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:08 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:08 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 06:54:08 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 06:54:08 INFO - Using env: {'DISPLAY': ':0', 06:54:08 INFO - 'HOME': '/home/cltbld', 06:54:08 INFO - 'LANG': 'en_US.UTF-8', 06:54:08 INFO - 'LANGUAGE': 'en_US:en', 06:54:08 INFO - 'LOGNAME': 'cltbld', 06:54:08 INFO - 'MAIL': '/var/mail/cltbld', 06:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:08 INFO - 'MOZ_NO_REMOTE': '1', 06:54:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:08 INFO - 'NO_EM_RESTART': '1', 06:54:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:08 INFO - 'SHELL': '/bin/bash', 06:54:08 INFO - 'SHLVL': '1', 06:54:08 INFO - 'TERM': 'linux', 06:54:08 INFO - 'TMOUT': '86400', 06:54:08 INFO - 'USER': 'cltbld', 06:54:08 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:08 INFO - '_': '/tools/buildbot/bin/python'} 06:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:09 INFO - Downloading/unpacking psutil>=0.7.1 06:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:54:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:54:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:10 INFO - Installing collected packages: psutil 06:54:10 INFO - Running setup.py install for psutil 06:54:10 INFO - building 'psutil._psutil_linux' extension 06:54:10 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 06:54:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:54:11 INFO - building 'psutil._psutil_posix' extension 06:54:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:54:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:54:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:11 INFO - Successfully installed psutil 06:54:11 INFO - Cleaning up... 06:54:11 INFO - Return code: 0 06:54:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:54: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')]} 06:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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', '--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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:11 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 06:54:11 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 06:54:11 INFO - Using env: {'DISPLAY': ':0', 06:54:11 INFO - 'HOME': '/home/cltbld', 06:54:11 INFO - 'LANG': 'en_US.UTF-8', 06:54:11 INFO - 'LANGUAGE': 'en_US:en', 06:54:11 INFO - 'LOGNAME': 'cltbld', 06:54:11 INFO - 'MAIL': '/var/mail/cltbld', 06:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:11 INFO - 'MOZ_NO_REMOTE': '1', 06:54:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:11 INFO - 'NO_EM_RESTART': '1', 06:54:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:11 INFO - 'SHELL': '/bin/bash', 06:54:11 INFO - 'SHLVL': '1', 06:54:11 INFO - 'TERM': 'linux', 06:54:11 INFO - 'TMOUT': '86400', 06:54:11 INFO - 'USER': 'cltbld', 06:54:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:11 INFO - '_': '/tools/buildbot/bin/python'} 06:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:11 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 06:54:11 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 06:54:11 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 06:54:11 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 06:54:11 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 06:54:11 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 06:54:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:54:13 INFO - Installing collected packages: mozsystemmonitor 06:54:13 INFO - Running setup.py install for mozsystemmonitor 06:54:13 INFO - Successfully installed mozsystemmonitor 06:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:13 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 06:54:13 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 06:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:54:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:54:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54: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 06:54:16 INFO - Downloading docopt-0.6.1.tar.gz 06:54:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:54:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:16 INFO - Running setup.py install for blobuploader 06:54:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:54:16 INFO - Running setup.py install for requests 06:54:16 INFO - Running setup.py install for docopt 06:54:16 INFO - Successfully installed blobuploader requests docopt 06:54:16 INFO - Cleaning up... 06:54:16 INFO - Return code: 0 06:54:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:16 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')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 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')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:16 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 06:54:16 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 06:54:16 INFO - Using env: {'DISPLAY': ':0', 06:54:16 INFO - 'HOME': '/home/cltbld', 06:54:16 INFO - 'LANG': 'en_US.UTF-8', 06:54:16 INFO - 'LANGUAGE': 'en_US:en', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MAIL': '/var/mail/cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SHLVL': '1', 06:54:16 INFO - 'TERM': 'linux', 06:54:16 INFO - 'TMOUT': '86400', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - '_': '/tools/buildbot/bin/python'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:16 INFO - Running setup.py (path:/tmp/pip-5MTV0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:17 INFO - Running setup.py (path:/tmp/pip-f7D591-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:17 INFO - Running setup.py (path:/tmp/pip-0FtzcI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:17 INFO - Running setup.py (path:/tmp/pip-1zCx3Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:17 INFO - Running setup.py (path:/tmp/pip-XvAUQU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:17 INFO - Running setup.py (path:/tmp/pip-SXvDH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:17 INFO - Running setup.py (path:/tmp/pip-vs3Ehf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:17 INFO - Running setup.py (path:/tmp/pip-9JV5d3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:17 INFO - Running setup.py (path:/tmp/pip-WAUsCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:17 INFO - Running setup.py (path:/tmp/pip-4GMgpH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:17 INFO - Running setup.py (path:/tmp/pip-jLggPb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:17 INFO - Running setup.py (path:/tmp/pip-ycanHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:17 INFO - Running setup.py (path:/tmp/pip-U7PGKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:17 INFO - Running setup.py (path:/tmp/pip-B1YLe6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:17 INFO - Running setup.py (path:/tmp/pip-5KpdvX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:18 INFO - Running setup.py (path:/tmp/pip-s2wH7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:18 INFO - Running setup.py (path:/tmp/pip-FA2BLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:18 INFO - Running setup.py install for manifestparser 06:54:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Running setup.py install for mozcrash 06:54:18 INFO - Running setup.py install for mozdebug 06:54:18 INFO - Running setup.py install for mozdevice 06:54:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Running setup.py install for mozfile 06:54:18 INFO - Running setup.py install for mozhttpd 06:54:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Running setup.py install for mozinfo 06:54:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Running setup.py install for mozInstall 06:54:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:54:18 INFO - Running setup.py install for mozleak 06:54:19 INFO - Running setup.py install for mozlog 06:54:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Running setup.py install for moznetwork 06:54:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Running setup.py install for mozprocess 06:54:19 INFO - Running setup.py install for mozprofile 06:54:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Running setup.py install for mozrunner 06:54:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Running setup.py install for mozscreenshot 06:54:19 INFO - Running setup.py install for moztest 06:54:19 INFO - Running setup.py install for mozversion 06:54:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:19 INFO - Cleaning up... 06:54:19 INFO - Return code: 0 06:54:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:19 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')]} 06:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:19 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')]} 06:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:19 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:19 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 06:54:19 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 06:54:19 INFO - Using env: {'DISPLAY': ':0', 06:54:19 INFO - 'HOME': '/home/cltbld', 06:54:19 INFO - 'LANG': 'en_US.UTF-8', 06:54:19 INFO - 'LANGUAGE': 'en_US:en', 06:54:19 INFO - 'LOGNAME': 'cltbld', 06:54:19 INFO - 'MAIL': '/var/mail/cltbld', 06:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:19 INFO - 'MOZ_NO_REMOTE': '1', 06:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:19 INFO - 'NO_EM_RESTART': '1', 06:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:19 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:19 INFO - 'SHELL': '/bin/bash', 06:54:19 INFO - 'SHLVL': '1', 06:54:19 INFO - 'TERM': 'linux', 06:54:19 INFO - 'TMOUT': '86400', 06:54:19 INFO - 'USER': 'cltbld', 06:54:19 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:19 INFO - '_': '/tools/buildbot/bin/python'} 06:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:20 INFO - Running setup.py (path:/tmp/pip-VPVfLN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:20 INFO - Running setup.py (path:/tmp/pip-R07yyS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:20 INFO - Running setup.py (path:/tmp/pip-pvQ514-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:20 INFO - Running setup.py (path:/tmp/pip-lVmBUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:20 INFO - Running setup.py (path:/tmp/pip-XOkCqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:20 INFO - Running setup.py (path:/tmp/pip-M14vFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:20 INFO - Running setup.py (path:/tmp/pip-FaJPJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:20 INFO - Running setup.py (path:/tmp/pip-bmP6nL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:20 INFO - Running setup.py (path:/tmp/pip-pkw4q3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:20 INFO - Running setup.py (path:/tmp/pip-8e991t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:20 INFO - Running setup.py (path:/tmp/pip-Gn8NMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:20 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)) 06:54:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:20 INFO - Running setup.py (path:/tmp/pip-BB0A3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:21 INFO - Running setup.py (path:/tmp/pip-3RIC8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:21 INFO - Running setup.py (path:/tmp/pip-Cz_dl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:21 INFO - Running setup.py (path:/tmp/pip-n9MU2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:21 INFO - Running setup.py (path:/tmp/pip-YC9FsZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:54:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:21 INFO - Running setup.py (path:/tmp/pip-dkvNKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:23 INFO - Downloading blessings-1.5.1.tar.gz 06:54:23 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 06:54:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:23 INFO - Installing collected packages: blessings 06:54:23 INFO - Running setup.py install for blessings 06:54:23 INFO - Successfully installed blessings 06:54:23 INFO - Cleaning up... 06:54:23 INFO - Return code: 0 06:54:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:54:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:23 INFO - Reading from file tmpfile_stdout 06:54:23 INFO - Current package versions: 06:54:23 INFO - argparse == 1.2.1 06:54:23 INFO - blessings == 1.5.1 06:54:23 INFO - blobuploader == 1.2.4 06:54:23 INFO - docopt == 0.6.1 06:54:23 INFO - manifestparser == 1.1 06:54:23 INFO - mozInstall == 1.12 06:54:23 INFO - mozcrash == 0.16 06:54:23 INFO - mozdebug == 0.1 06:54:23 INFO - mozdevice == 0.47 06:54:23 INFO - mozfile == 1.2 06:54:23 INFO - mozhttpd == 0.7 06:54:23 INFO - mozinfo == 0.9 06:54:23 INFO - mozleak == 0.1 06:54:23 INFO - mozlog == 3.1 06:54:23 INFO - moznetwork == 0.27 06:54:23 INFO - mozprocess == 0.22 06:54:23 INFO - mozprofile == 0.27 06:54:23 INFO - mozrunner == 6.11 06:54:23 INFO - mozscreenshot == 0.1 06:54:23 INFO - mozsystemmonitor == 0.0 06:54:23 INFO - moztest == 0.7 06:54:23 INFO - mozversion == 1.4 06:54:23 INFO - psutil == 3.1.1 06:54:23 INFO - requests == 1.2.3 06:54:23 INFO - wsgiref == 0.1.2 06:54:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:23 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:23 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 06:54:23 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 06:54:23 INFO - Using env: {'DISPLAY': ':0', 06:54:23 INFO - 'HOME': '/home/cltbld', 06:54:23 INFO - 'LANG': 'en_US.UTF-8', 06:54:23 INFO - 'LANGUAGE': 'en_US:en', 06:54:23 INFO - 'LOGNAME': 'cltbld', 06:54:23 INFO - 'MAIL': '/var/mail/cltbld', 06:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:23 INFO - 'MOZ_NO_REMOTE': '1', 06:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:23 INFO - 'NO_EM_RESTART': '1', 06:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:23 INFO - 'SHELL': '/bin/bash', 06:54:23 INFO - 'SHLVL': '1', 06:54:23 INFO - 'TERM': 'linux', 06:54:23 INFO - 'TMOUT': '86400', 06:54:23 INFO - 'USER': 'cltbld', 06:54:23 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:23 INFO - '_': '/tools/buildbot/bin/python'} 06:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 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)) 06:54:23 INFO - Cleaning up... 06:54:23 INFO - Return code: 0 06:54:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:23 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:23 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 06:54:23 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 06:54:23 INFO - Using env: {'DISPLAY': ':0', 06:54:23 INFO - 'HOME': '/home/cltbld', 06:54:23 INFO - 'LANG': 'en_US.UTF-8', 06:54:23 INFO - 'LANGUAGE': 'en_US:en', 06:54:23 INFO - 'LOGNAME': 'cltbld', 06:54:23 INFO - 'MAIL': '/var/mail/cltbld', 06:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:23 INFO - 'MOZ_NO_REMOTE': '1', 06:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:23 INFO - 'NO_EM_RESTART': '1', 06:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:23 INFO - 'SHELL': '/bin/bash', 06:54:23 INFO - 'SHLVL': '1', 06:54:23 INFO - 'TERM': 'linux', 06:54:23 INFO - 'TMOUT': '86400', 06:54:23 INFO - 'USER': 'cltbld', 06:54:23 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:23 INFO - '_': '/tools/buildbot/bin/python'} 06:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:23 INFO - Downloading/unpacking jsonschema 06:54:23 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 06:54:23 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 06:54:23 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 06:54:23 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 06:54:23 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 06:54:23 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 06:54:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:25 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 06:54:25 INFO - Downloading/unpacking functools32 (from jsonschema) 06:54:25 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 06:54:25 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 06:54:25 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 06:54:25 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 06:54:25 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 06:54:25 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 06:54:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:54:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:25 INFO - warning: no files found matching '*.txt' 06:54:25 INFO - no previously-included directories found matching 'build' 06:54:25 INFO - no previously-included directories found matching 'dist' 06:54:25 INFO - no previously-included directories found matching '.git*' 06:54:25 INFO - Installing collected packages: jsonschema, functools32 06:54:25 INFO - Running setup.py install for functools32 06:54:26 INFO - warning: no files found matching '*.txt' 06:54:26 INFO - no previously-included directories found matching 'build' 06:54:26 INFO - no previously-included directories found matching 'dist' 06:54:26 INFO - no previously-included directories found matching '.git*' 06:54:26 INFO - Successfully installed jsonschema functools32 06:54:26 INFO - Cleaning up... 06:54:26 INFO - Return code: 0 06:54:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:26 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 0x7f0be37cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', '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 06:54:26 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 06:54:26 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 06:54:26 INFO - Using env: {'DISPLAY': ':0', 06:54:26 INFO - 'HOME': '/home/cltbld', 06:54:26 INFO - 'LANG': 'en_US.UTF-8', 06:54:26 INFO - 'LANGUAGE': 'en_US:en', 06:54:26 INFO - 'LOGNAME': 'cltbld', 06:54:26 INFO - 'MAIL': '/var/mail/cltbld', 06:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:26 INFO - 'MOZ_NO_REMOTE': '1', 06:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:26 INFO - 'NO_EM_RESTART': '1', 06:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:26 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:26 INFO - 'SHELL': '/bin/bash', 06:54:26 INFO - 'SHLVL': '1', 06:54:26 INFO - 'TERM': 'linux', 06:54:26 INFO - 'TMOUT': '86400', 06:54:26 INFO - 'USER': 'cltbld', 06:54:26 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:26 INFO - '_': '/tools/buildbot/bin/python'} 06:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:26 INFO - Downloading/unpacking flake8 06:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:54:27 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 06:54:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:54:28 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 06:54:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 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 06:54:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:54:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:28 INFO - no previously-included directories found matching 'docs/_build' 06:54:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:54:28 INFO - Running setup.py install for pep8 06:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:28 INFO - no previously-included directories found matching 'docs/_build' 06:54:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:54:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:54:28 INFO - Cleaning up... 06:54:28 INFO - Return code: 0 06:54:28 INFO - Running post-action listener: _resource_record_post_action 06:54:28 INFO - Running post-action listener: _start_resource_monitoring 06:54:28 INFO - Starting resource monitoring. 06:54:28 INFO - ##### 06:54:28 INFO - ##### Running install step. 06:54:28 INFO - ##### 06:54:28 INFO - Running pre-action listener: _resource_record_pre_action 06:54:28 INFO - Running main action method: install 06:54:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:29 INFO - Reading from file tmpfile_stdout 06:54:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:54:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:54:29 INFO - Reading from file tmpfile_stdout 06:54:29 INFO - Output received: 06:54:29 INFO - Usage: mozinstall [options] installer 06:54:29 INFO - Options: 06:54:29 INFO - -h, --help show this help message and exit 06:54:29 INFO - -d DEST, --destination=DEST 06:54:29 INFO - Directory to install application into. [default: 06:54:29 INFO - "/builds/slave/test-pgo"] 06:54:29 INFO - --app=APP Application being installed. [default: firefox] 06:54:29 INFO - mkdir: /builds/slave/test-pgo/build/application 06:54:29 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'] 06:54:29 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 06:54:44 INFO - Reading from file tmpfile_stdout 06:54:44 INFO - Output received: 06:54:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:54:44 INFO - Running post-action listener: _resource_record_post_action 06:54:44 INFO - ##### 06:54:44 INFO - ##### Running run-tests step. 06:54:44 INFO - ##### 06:54:44 INFO - Running pre-action listener: _resource_record_pre_action 06:54:44 INFO - Running main action method: run_tests 06:54:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:54:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:54:44 INFO - Python 2.7.3 06:54:44 INFO - Return code: 0 06:54:44 INFO - grabbing minidump binary from tooltool 06:54: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')]} 06:54: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 0x2cde350>, '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 0x2cdf250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cdf6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:54: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 06:54: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 06:54:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:44 INFO - Return code: 0 06:54:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:54:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:54:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:54:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:54:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:54:45 INFO - Return code: 0 06:54: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/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:54: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/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 06:54:45 INFO - Using env: {'DISPLAY': ':0', 06:54:45 INFO - 'HOME': '/home/cltbld', 06:54:45 INFO - 'LANG': 'en_US.UTF-8', 06:54:45 INFO - 'LANGUAGE': 'en_US:en', 06:54:45 INFO - 'LOGNAME': 'cltbld', 06:54:45 INFO - 'MAIL': '/var/mail/cltbld', 06:54:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:45 INFO - 'MOZ_NO_REMOTE': '1', 06:54:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:45 INFO - 'NO_EM_RESTART': '1', 06:54:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:54:45 INFO - 'SHELL': '/bin/bash', 06:54:45 INFO - 'SHLVL': '1', 06:54:45 INFO - 'TERM': 'linux', 06:54:45 INFO - 'TMOUT': '86400', 06:54:45 INFO - 'USER': 'cltbld', 06:54:45 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353', 06:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:45 INFO - '_': '/tools/buildbot/bin/python'} 06:54: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/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 06:54:45 INFO - mozversion INFO | application_buildid: 20151217043003 06:54:45 INFO - mozversion INFO | application_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 06:54:45 INFO - mozversion INFO | application_display_name: Nightly 06:54:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:45 INFO - mozversion INFO | application_name: Firefox 06:54:45 INFO - mozversion INFO | application_remotingname: firefox 06:54:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:54:45 INFO - mozversion INFO | application_vendor: Mozilla 06:54:45 INFO - mozversion INFO | application_version: 46.0a1 06:54:45 INFO - mozversion INFO | platform_buildid: 20151217043003 06:54:45 INFO - mozversion INFO | platform_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 06:54:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:54:45 INFO - mozversion INFO | platform_version: 46.0a1 06:54:45 INFO - 2015-12-17 06:54:45,253 DEBUG : using testdate: 1450364085 06:54:45 INFO - 2015-12-17 06:54:45,253 DEBUG : actual date: 1450364085 06:54:45 INFO - 2015-12-17 06:54:45,301 INFO : starting webserver on 'localhost:44616' 06:54:45 INFO - 2015-12-17 06:54:45,302 INFO : Starting test suite talos-linux64-ix-058.e 06:54:45 INFO - 2015-12-17 06:54:45,302 INFO : Starting test dromaeo_css 06:54:45 INFO - 2015-12-17 06:54:45,302 DEBUG : operating with platform_type : linux_ 06:54:45 INFO - 2015-12-17 06:54:45,303 INFO : Initialising browser for dromaeo_css test... 06:54:45 INFO - 2015-12-17 06:54:45,319 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUYfeIC/profile http://localhost:44616/getInfo.html 06:54:49 INFO - 2015-12-17 06:54:49,760 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:54:49 INFO - 2015-12-17 06:54:49,761 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:54:49 INFO - 2015-12-17 06:54:49,761 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:54:49 INFO - 2015-12-17 06:54:49,761 DEBUG : BROWSER_OUTPUT: __metrics 06:54:49 INFO - 2015-12-17 06:54:49,889 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:54:50 INFO - 2015-12-17 06:54:50,743 INFO : Browser initialized. 06:54:50 INFO - 2015-12-17 06:54:50,743 INFO : Running cycle 1/1 for dromaeo_css test... 06:54:50 INFO - 2015-12-17 06:54:50,744 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUYfeIC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:55:02 INFO - 2015-12-17 06:55:02,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 143556608 06:55:02 INFO - 2015-12-17 06:55:02,604 DEBUG : BROWSER_OUTPUT: 06:55:52 INFO - 2015-12-17 06:55:52,225 DEBUG : BROWSER_OUTPUT: 1450364152221 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] 06:58:01 INFO - 2015-12-17 06:58:01,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44616/tests/dromaeo/cssquery-ext.html) 06:58:02 INFO - 2015-12-17 06:58:02,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 150339584 06:58:02 INFO - 2015-12-17 06:58:02,166 DEBUG : BROWSER_OUTPUT: 07:01:04 INFO - 2015-12-17 07:01:04,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-ext.html (next: http://localhost:44616/tests/dromaeo/cssquery-jquery.html) 07:01:04 INFO - 2015-12-17 07:01:04,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 144654336 07:01:04 INFO - 2015-12-17 07:01:04,682 DEBUG : BROWSER_OUTPUT: 07:04:06 INFO - 2015-12-17 07:04:06,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44616/tests/dromaeo/cssquery-mootools.html) 07:04:07 INFO - 2015-12-17 07:04:07,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 146182144 07:04:07 INFO - 2015-12-17 07:04:07,022 DEBUG : BROWSER_OUTPUT: 07:07:08 INFO - 2015-12-17 07:07:08,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44616/tests/dromaeo/cssquery-prototype.html) 07:07:09 INFO - 2015-12-17 07:07:09,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 144670720 07:07:09 INFO - 2015-12-17 07:07:09,280 DEBUG : BROWSER_OUTPUT: 07:10:11 INFO - 2015-12-17 07:10:11,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44616/tests/dromaeo/cssquery-yui.html) 07:10:12 INFO - 2015-12-17 07:10:12,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 144969728 07:10:12 INFO - 2015-12-17 07:10:12,237 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/dromaeo/cssquery-yui.html (next: http://localhost:44616/tests/dromaeo/cssquery-dojo.html) 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 147189760 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:13:14 INFO - 2015-12-17 07:13:14,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:13:14 INFO - 2015-12-17 07:13:14,972 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.9999999999995;3179.9205019874516;3204.4392231359534;3227.6933691299328;3234.8867789627366;5287.762050707727;5300.204969254613;5362.731863406829;5375.301210842595;5375.3280839895015;5393.568514518839;5404.945950540494;5420.295361602986;5428.864278393042;5505.119180931052;4944.72803995781;5036.697798132105;5047.47001564836;5110.054639891613;5124.385073791132;4863.36776219091;4939.110960027194;4967.031428871372;4967.950320496803;4970.353853998975;4805.879853003668;4910.950890491121;4931.038447502757;4934.358533390637;5012.273220383042;4905.092557876804;4947.9505204947845;4961.751912404401;4970.055689419035;5041.420236672793;4946.826861059882;4958.727270000149;4960.379952505937;4976;5000.0999820032375;5105.566026887719;5141.922871156936;5198.376194856603;5206.661566998133;5364.249005139283;5782.739776710058;5895.410458954113;5898.882022359572;5921.348651648315;5933.317668468138;5961.374055724174;5963.642181469126;5969.104634304846;5976.223090998186;5985.850353741148;5315.28243687105;5402.6758394496455;5421.484958928895;5427.050266203399;5428.321459817523;5999.6400215986305;6043.395660433922;6050.9394906050375;6058.485028772516;6139.10982907476;5835.212246346774;5854.736536855852;5855.2973643163095;5856.502197313276;5865.794697185578;5809.2738407699035;5813.302403711582;5859.765609375577;5886.735096920649;5932.2584676915385;5822.970885145632;5830.883382332415;5847.26909136358;5847.9415205848245;5898.64608123514;5834.5624078194305;5841.7371218295275;5842.094475356326;5846.7076646167525;5857.531397488191;4392.736435813861;4459.687821852504;4479.820807167677;4486.842960496367;4521.864344069683;4002.1195337025806;4042.757434553936;4055.3105971984833;4060.4721386219603;4096.26267271888;5613.354464236665;5619.634723742944;5625.634333768292;5626.831195064155;5654.802081927113;5732.971335143297;5801.303843538718;5861.736221870026;5941.524678025748;5985.910211346833;5507.944920550824;5575.581831362664;5620.831375058755;5629.831105066854;5633.549316054706;4886.828960986349;5081.83117882889;5092.2361645753435;5120.615953803405;5126.384833819965;5920.437558431942;5930.911036334458;5993.640381577119;6001.5798894077;6038.607490513103;5896.292444906639;5944.048952167633;5949.375315591974;5957.880842383041;5964.940350596438;5906.970465147647;6010.939890601213;6018.909716354171;6027.126066720389;6027.879442411215;5719.113537401709;5771.797987070432;5798.971005144947;5816.069428891357;5855.648661080349;5891.528677705859;5936.28764548257;5936.8812623748145;5939.762409503572;5944.64332140073;5628.718564071862;5660;5734.426557344233;5791.305043394819;5796.82609521715;5733.483986441241;5737.770489180386;5749.8562535936935;5783.652980821164;5786.652800831964;5638.2670252866865;5657.5473962082115;5697.23087383198;5711.457411545896;5713.800016999385;5565.805196818092;5733.369329373682;5762.1068734346245;5788.450097240755;5895.322037965689;5678.886422271614;5680.573956953162;5688.402717714746;5689.2319536862;5695.430456954271 07:13:14 INFO - 2015-12-17 07:13:14,973 DEBUG : BROWSER_OUTPUT: |1;ext.html;565.0540296507731;600.0639003155077;607.5564837668501;609.1319869186408;624.1854380034057;34836.129096772594;35186.824065879664;35378;35461.64538354616;35529.822350888244;41281.79359103208;41568.37647435291;41754;41866.372004419885;42010.78994605023;8718.34612404069;8897.110288971116;8928.955355223216;8935.821283574325;8960.327975401839;8691.695790647296;8767.035626081126;8768.824623507558;8774.385792994493;8787.428817126898;8720.563971801415;8794.51630160341;8810.251128654072;8813.118688131168;8820.294376449869;8699.739007829776;8734.737957861305;8743.038265790758;8760.255378292853;8764.342674299422;8598.398112132154;8695.130486951317;8747.562621868945;8764.693235736782;8785.64857405703;38369;38503;38596;38818.641347552984;39023;3280.803151810899;3336.8832090876704;3400.6769356911054;3440.4839274109086;3628.38317486028;29201.415971680446;29357.559636605467;29364.18715242203;29647;30072.548911766342;3967.8016099194924;3976.443297938291;3989.6209860063245;4001.4397984282223;4073.287174744408;239042;240349;240960;242260;243168.78415607987;54888.176677349875;55333;55653.721731391895;56205;57511;51615.48384516182;51683.741581291855;51782.74108629508;51821.222681659805;51825.22262166071;13353.46586136563;13530.458781648624;13576.59270221895;13584.388702508411;13594.660133496543;9964.451955142536;9983.60065597368;10010.799784004279;10047.799044019224;10058.899411005943;18663.813361866207;19261;19435.416937491897;19549.21803127859;19588.314408995902;7542.509736867086;7573.35626471756;7746.690132394641;7784.571848548384;7790.220977902164;914.7027216154777;928.2481190235931;1039.0596510158318;1081.3890152064216;1135.7671677306132;28055;28535.19781990356;28687.426251474855;28789.136325910255;28924.566131508043;1000.7248006798043;1007.6775431861734;1091.3288327678579;1131.2194585735815;1165.9825102623468;12436.316002619942;13329.333533323295;13422.798658020138;13487.932560337333;15181;242854;247951;248094;248584;250037;46976.5302346979;47084.7645761769;47272.290915636295;47555.52444475511;47582.28626570604;1261.8422697162855;1265.8923991460645;1268.35313989864;1283.525095714573;1318.235423454394;26464.470710586065;28750;28893.711062889102;29046.41907161887;29160.27099322534;45255;45314.54685453235;45565.54434455613;45639;45758.084838303716;280722;281441;282484;282856;283118;29970.700292997662;30297.394052119274;30437.086887393412;30625.549956003022;30748.385032299677;41389.793051034554;42011.36982945197;42317;42357.15285694207;42532.149357012066;35497.467537986435;35733.64266357303;35813.28373432569;36886.815565922;36945.26109477849;35662.64337356593;35982.4602630966;36154.90678016956;36933.81533092317;37028.259434810614;35130.121746955505;35218.82390588031;35319;35330.29339413249;35678;27756.861215693792;27880.58179127274;29381.11856644304;29752.85123574368;30027.849860750557;24265.75734242635;24970.77484138468;26063.218103456926;26559.867200663874;26571.468570628866 07:13:14 INFO - 2015-12-17 07:13:14,976 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.6666749916334;344.66395264617;344.73799912066835;346.5100069700288;347.0802373709668;14480.710385792278;14782.334794934226;16708;17123.315067397303;18213.27146914122;14282.285885705725;15607.375704971815;17773;18147.90926045371;18333;5400.594955378343;5542.889142217154;5546.168074788774;5546.611737178399;5558.666480011192;6279.434850863444;6471.741130354781;6515.381038801306;6519.902201466982;6531.346865313478;6440.581362211441;6566.934330656704;6780.627065511395;6822.4200942919915;6834.419074378684;6272.5922815016875;6759.019942108392;6772.492063095263;6776.491763117786;6810.693518791666;6178.938210617881;6207.224096987877;6224.533160013018;6232.968835155841;6245.6252624842655;20778.272760453463;21445.67831482529;21603.891980540153;23876.164334248217;23879.641805372932;2132.040581738224;2212.904612216963;2285.9657105143438;2292.6904867842795;2352.870592117433;14122;14188.787168192486;14347.78478322826;14735.484258050918;14808.851911480855;1986.4437957371815;2001.8398528117716;2049.893057748814;2050.846186536001;2080.44868109951;58979.410205897824;59231.40768592302;60086;65006.34993650098;69429;10141.695749127539;10331.793364132825;10485.580576776996;10515.52680129396;14669;13323;13352.599422017354;13390.531331403354;13452.461901524026;13453.932730336286;7057.647117644097;7069.257727938595;7075.327843854826;7121.28787121294;7156.463265255126;6640.701168447432;6683.331666833375;6772.2211945625895;6809.182898052265;6863.039174515572;4540.5913467787395;4550.953280745447;4630.699004564693;4643.791029403685;4678.69588476748;1877.6714075037087;1896.8577356698304;1898.5253686578355;1920.6254780317984;1926.1139875657354;899.4962820820231;939.3424602778083;981.9410835349902;1032.5766435761452;1068.5779117248644;17190.91404542994;17248;17389.304427822746;17523;17567.64864702699;919.8252332056887;920.2775820980632;926.786839027014;986.2652324018652;1009.4599389326675;10034.498275086216;10105.9494702526;10214.182865370753;10233.539490722935;10244.487775611338;538410;540110;585169;589639;601741;84545.57727211325;85439;88202.11797882068;88561.55719221491;91082;1109.351029647649;1123.309164863603;1139.7036770439745;1149.4195431307303;1153.9596114135966;15560.066396016275;15587.22063896778;16170.434034808724;16434.342626294816;16767.832321676626;35811;36161.27677446384;36294.637053630184;36306.81846590856;36875.63124368722;48106.556803295956;48160.27759583679;48254;49946;52639;9870.407775533491;9887.653932112342;9941.502924853872;10002.599896004078;10080.445575493419;13730.45078196861;17732.29070837152;18081.909590451964;18510.907445462686;18565.72151417703;14063.507777227747;14314.570562883131;14329.987603471045;14585.270736462922;14906.627334316729;14408.351624176728;14578.271086445848;14625.85374146245;14850.554483365517;15253.466128685443;14921.850781492047;14976.400943962119;15118.697626047198;15334.9233253833;15752.92123539375;9735.756606084622;9743.902560974582;9794.75513112178;9849.556769945513;9896.752581185528;10589;11981.820272695742;14468.927655361656;14501.709965800414;15223.92388038097 07:13:14 INFO - 2015-12-17 07:13:14,976 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.0812904128486;1674.3637417781242;1744.4243399678107;1745.258265237274;1746.6943284925135;6964.8258793530185;7165.068541089658;7176.712931482747;7706.190849960757;7774.572398518093;7818.140004599503;7845.80385490363;7857.292843644071;7947.602619868998;7956.880646790303;2204.581129585382;2237.574860776447;2239.428945618865;2241.7758224177614;2243.6971008913833;2233.810126139272;2248.4940888300084;2275.1695631094613;2275.977240227593;2288.336382449088;2229.5429436965383;2246.539459410825;2273.795358417742;2282.2354511238755;2288.3592594073602;2225.365770755327;2234.497238121426;2247.3932038349717;2264.2188444986537;2274.613315736329;2259.085070546415;2282.0073268128417;2284.8743319117443;2285.31440567829;2290.4960908600083;7740.225977402271;7775.1447340792465;7839.882401763978;7877.330426913719;7907.367410607138;4361.323994780814;4412.823487060514;4447.355133505624;4474.2841145416905;4478.686491945533;3027.7275045246033;3037.9088627341216;3106.8446577671025;3142.795718278305;3148.3703259347994;1000.9249306301983;1019.5819713917332;1025.3386565665178;1029.7477118106037;1050.4380156616173;10272.537735801907;10384.636537721144;10400.583976640924;10415.791684166274;10448.32085914413;3959.940600890989;4003.319435695939;4029.2545879012478;4031.07285324377;4110.815013324408;8584.141585841366;8589.742307730778;8614;8631.525266110424;8644.265237454887;4448.733076015449;4453.910921781546;4463.906342945999;4463.977680111579;4489.595936365743;4041;4117;4148.91702165955;4184.91630167401;4190;3465.8613655454005;3496.6852983231634;3501.3697534443536;3502.9299414011575;3508.210652603195;1041.4792603698152;1044.0551301072542;1045.451138152476;1047.2459828923315;1052.1057101463848;1307.8888294494884;1311.4819646239682;1313.4614807928704;1320.2540564580981;1329.322045756671;7287.198408175096;7358.889616655754;7413.666385012687;7429.5542267464125;7446.888296675555;465.8765427161805;471.8537253451441;472.5274725274725;475.35589276530493;497.59197458084026;5742.942570574241;5777.653340799566;5816;5825.300963884276;5838.481994681413;8563.929508811398;8869.467831929976;8999.505027223435;9068.501232432147;9173.40372875761;8941.865872011926;8956;8959.41763785352;9001.099890011077;9085.682001129928;7007.334303241184;7114.39527640146;7179.456416870503;7198.316159964795;7235.819104522429;6902.8619427610165;6938.098047253825;6946.0622815919205;6967.65161741921;6969.477289203229;7921.801954951173;8086.555239461651;8169.673213071411;8253.669853205805;8329.833403331779;8080.868678385148;8187.222213889671;8226.670933162606;8298.54358010291;8301.335893128657;5824.767009319579;6006.519478441802;6166.784162554289;6508.7721929734125;6568.540202185801;7406.555606663617;7432.70269189248;7456.96271518639;7467.141278753013;7521.435892308208;6919.965400172967;7018.719251229893;7129.108861392326;7204.783856484314;7252.38354739853;6995.055667485028;6998.930010699828;7075.115610548682;7099.609521476162;7116.893246601202;6965.199002114821;6996.090508233897;7056.717731290691;7057.329553692391;7083.114610673666;6368.42684158428;6377.649229292433;6396.616203027833;6406.967965160145;6428.935710642833;6444.806655800334;6454.225492940689;6469.676516174267;6487.935120648733;6633.900491492535 07:13:14 INFO - 2015-12-17 07:13:14,977 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.39346045782787;329.06053218062425;332.8036458489491;336.26190511826553;340.4977657954516;6331.081993111002;6344.587601805891;6344.968275158623;6354.459870910967;6464.12734280872;6281.214848143982;6290.842728931779;6344.1118243445835;6386.521010924188;6388.425041746254;4787.40157480315;4835.975820120894;4849.757512124397;4853.563179313861;4859.635527335447;4767.785449654756;4819.253015782542;4832.830850920219;4834.830780922668;4839.467658557556;4709.317149013391;4768.809247630091;4769.427668679746;4787.281907713836;4812.133815913135;4759.595434388081;4770.61835053195;4783.1868582341085;4786.425628924517;4808.350872632185;4116.382542618601;4155.231282212801;4157.10622216225;4174.290370636999;4175.728577642443;6017.097435384683;6024.307204671475;6033.336333003366;6039.607425517372;6065.02959526478;5459.781608735646;5587.161925711135;5605.682664573822;5613.270274864282;5626.746796394172;6779.017042528806;6799.5920244785475;6838.179418469816;6842.931570684279;6854.280300568468;4567.269236922077;4573;4584.885377865547;4586.633069354443;4589.311603259504;6922.376986071277;6924.389700972017;6964.373206411447;6965.199002114771;6994.720211191546;4682.180618391768;4684.929726054112;4703.506131856174;4707.364505791743;4714.45783734868;4758.072175925661;4761.761911904391;4766.451858036301;4770.189067858472;4779.761011949388;5527.226188333637;5543.002259593312;5555.749991250404;5579.9163012554845;5589.217509548666;6529.314421985718;6681.098051763047;6681.699323530453;6681.732730690718;6685.732570697215;1639.9754003689955;1646.1111000060073;1686.6289416328389;1688.5609741467306;1698.405558054671;1106.546316010448;1107.6123356825208;1122.814735568622;1123.2361993844102;1132.6375559820942;6341.207349081365;6389.169407977026;6475.158229430144;6493.610383377012;6513.381228783258;6921.515493915377;6977.372036516738;6978.197507286625;6979.825504362431;6990.685419156151;6351.396617321347;6456.547276862669;6464.515161362917;6466.741330346734;6475.417212450902;3825.6748176404762;3870.806459677005;3880.80595970206;3882.4176373544196;3885.941710874339;7226.819329516804;7232.602206878567;7292.124945006633;7297.197308296083;7305.3425191732995;7087.114110736158;7186.4549121939035;7213.350798428167;7244.311790379906;7331.083614548182;7287.234840341794;7293.598852063187;7328.560286382834;7337.229590892986;7350.375218106521;7060.611666358194;7111.111111111111;7116.181639111568;7116.786496405116;7120.964395177991;6794.72821087151;7032.1912980007955;7038.859222815618;7070.611116388648;7072.575645461083;7278.344948954407;7283.417326613752;7309.963450182715;7314.158871729819;7325.267473252632;4731.479537250969;4766.976165119152;4774.236122220428;4790.664653474223;4795.64032697556;6858.657067146523;6890.20762612306;7016.894746578703;7131.750388736369;7140.178879428932;6835.555688880207;6854.417374523221;6893.862122757617;6900.861982760216;6930.5148639594745;6853.383195512428;6884.965575172092;6901.75843845463;6904.482163837632;6911.17065952089;6625.17185351831;6684.966575167093;6739.663016849236;6739.898901516383;6754.696038678173;6886.311368863074;6907.34380233877;6919.654017299215;6922.446204303745;6931.861362772615;6750.898736518858;6758.695858686469;6760.357766012221;6762.661866906733;6790.45676345901 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: |5;yui.html;734.8750712378896;807.7495976247363;812.3054788156127;823.3948048184579;872.106091256462;12964.48142074317;13151.079424440293;13216.14095083819;13248.271345076017;13301.201927884322;12886.548970786025;13528.120672156303;13532.932335338333;13582.52461163857;13615.183089014667;816.2286639126029;824.2375802382787;833.1293797981124;851.9946463173453;852.5438890193748;835.7701632051204;840.6385254340631;842.7808769719886;844.923956843884;847.1867007672641;866.6100254885296;872.2672954718035;874.623911717961;874.8075423406872;875.3434923807145;853.2406158518924;854.0989256334534;856.3876828067899;863.5897948474487;868.6525389844049;634.7238951056305;640.5452128988424;640.8173670503884;643.3791391307363;643.5495153392598;13212.405441755143;13327.400266988008;13429.127106738031;13435.596932092052;13464;12058;12110.757784844342;12166.695832604255;12224.449899754532;12802.103852730312;10299.794004119876;10826.296290741077;10914.181436392302;11008.174386920933;11056.281341712764;3548.520949671787;3590.730695197871;3679.0802299425145;3723.757955732896;3727.0868637183794;45093.774531127136;46147.53852461466;46638.300425493646;46639.06721865578;46810.29784553235;9671.177949874198;9690.612375505041;9777.241905027695;9787.314887957917;9818.018198180125;17324.480265592054;17613.295468181386;17643.73534396985;17673.646527069643;17707.73438398425;7342;7431.777046688608;7541.585212813348;7544.47188696786;7639.579823109671;4264.168487145039;4338.197433474817;4349.434573505424;4413.205622987829;4446.088551846864;3041.81749095055;3074.4773388524004;3089.9536506952413;3094.5512900629283;3114.0813460029344;551.2723205368875;565.4289167940327;567.4467394290616;569.4647031790104;571.894199573072;649.2378404403752;651.569963823874;665.2690704657408;679.0018672551341;689.5724650716588;8116.066652335057;8309.37679674027;8464.298725863557;8700.912990870136;8801.383903126847;641.131267133028;650.4113331947343;659.7492952678048;675.1223409567641;731.2687312687312;3852.6339997700175;4002.219567184371;4060.6954478414236;4078.7144899856726;4102.671786257092;54142.729286353315;54288.185677214875;54547;54712.17931730948;55923.72038139865;49230.75384623054;49551.50448495469;49607.503924960285;49700;50074.749626251636;44829.55170448254;45254;45640.5435945643;45720.08559828785;45817;8064.475809072626;8322.750317490485;8351.665933362841;8375.41372103947;8629.525376104375;33304.66695333113;33368.49947250842;33387;34649.82675086709;35272.82363588166;37415.62584374121;43835;43904.34143487914;44011;44017.559824401345;10046.497675116361;10112.696619101438;10228.130608898327;10619.840702389316;10710.839337409789;10966.396848173426;11066.289902247503;11181.385023823768;11254.94372528132;11627.12234427894;10441.112505437122;10508.264421490423;10633.096186823897;11211.831822522832;11251.943740281245;10701.678949631523;10706.73233169177;10724.356538607708;10937.343759374146;11240;10350;10440.843387349043;10795.892041079804;11196.160287978597;11570.157289927098;8782.301802520522;9535.284853636143;9555.569999349907;9847.753806154904;10339.948300258451;8907;9111.498867562348;9136.31477639193;9303.72088837336;9517.381370210915 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,313 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365194969__endTimestamp 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,979 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5444.00 Median:5688.40 stddev:621.97 (10.9%) stddev-sans-first:597.49 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: Values: 3159.0 3179.9 3204.4 3227.7 3234.9 5287.8 5300.2 5362.7 5375.3 5375.3 5393.6 5404.9 5420.3 5428.9 5505.1 4944.7 5036.7 5047.5 5110.1 5124.4 4863.4 4939.1 4967.0 4968.0 4970.4 4805.9 4911.0 4931.0 4934.4 5012.3 4905.1 4948.0 4961.8 4970.1 5041.4 4946.8 4958.7 4960.4 4976.0 5000.1 5105.6 5141.9 5198.4 5206.7 5364.2 5782.7 5895.4 5898.9 5921.3 5933.3 5961.4 5963.6 5969.1 5976.2 5985.9 5315.3 5402.7 5421.5 5427.1 5428.3 5999.6 6043.4 6050.9 6058.5 6139.1 5835.2 5854.7 5855.3 5856.5 5865.8 5809.3 5813.3 5859.8 5886.7 5932.3 5823.0 5830.9 5847.3 5847.9 5898.6 5834.6 5841.7 5842.1 5846.7 5857.5 4392.7 4459.7 4479.8 4486.8 4521.9 4002.1 4042.8 4055.3 4060.5 4096.3 5613.4 5619.6 5625.6 5626.8 5654.8 5733.0 5801.3 5861.7 5941.5 5985.9 5507.9 5575.6 5620.8 5629.8 5633.5 4886.8 5081.8 5092.2 5120.6 5126.4 5920.4 5930.9 5993.6 6001.6 6038.6 5896.3 5944.0 5949.4 5957.9 5964.9 5907.0 6010.9 6018.9 6027.1 6027.9 5719.1 5771.8 5799.0 5816.1 5855.6 5891.5 5936.3 5936.9 5939.8 5944.6 5628.7 5660.0 5734.4 5791.3 5796.8 5733.5 5737.8 5749.9 5783.7 5786.7 5638.3 5657.5 5697.2 5711.5 5713.8 5565.8 5733.4 5762.1 5788.5 5895.3 5678.9 5680.6 5688.4 5689.2 5695.4 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42442.13 Median:35670.32 stddev:66989.95 (187.8%) stddev-sans-first:67104.08 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: Values: 565.1 600.1 607.6 609.1 624.2 34836.1 35186.8 35378.0 35461.6 35529.8 41281.8 41568.4 41754.0 41866.4 42010.8 8718.3 8897.1 8929.0 8935.8 8960.3 8691.7 8767.0 8768.8 8774.4 8787.4 8720.6 8794.5 8810.3 8813.1 8820.3 8699.7 8734.7 8743.0 8760.3 8764.3 8598.4 8695.1 8747.6 8764.7 8785.6 38369.0 38503.0 38596.0 38818.6 39023.0 3280.8 3336.9 3400.7 3440.5 3628.4 29201.4 29357.6 29364.2 29647.0 30072.5 3967.8 3976.4 3989.6 4001.4 4073.3 239042.0 240349.0 240960.0 242260.0 243168.8 54888.2 55333.0 55653.7 56205.0 57511.0 51615.5 51683.7 51782.7 51821.2 51825.2 13353.5 13530.5 13576.6 13584.4 13594.7 9964.5 9983.6 10010.8 10047.8 10058.9 18663.8 19261.0 19435.4 19549.2 19588.3 7542.5 7573.4 7746.7 7784.6 7790.2 914.7 928.2 1039.1 1081.4 1135.8 28055.0 28535.2 28687.4 28789.1 28924.6 1000.7 1007.7 1091.3 1131.2 1166.0 12436.3 13329.3 13422.8 13487.9 15181.0 242854.0 247951.0 248094.0 248584.0 250037.0 46976.5 47084.8 47272.3 47555.5 47582.3 1261.8 1265.9 1268.4 1283.5 1318.2 26464.5 28750.0 28893.7 29046.4 29160.3 45255.0 45314.5 45565.5 45639.0 45758.1 280722.0 281441.0 282484.0 282856.0 283118.0 29970.7 30297.4 30437.1 30625.5 30748.4 41389.8 42011.4 42317.0 42357.2 42532.1 35497.5 35733.6 35813.3 36886.8 36945.3 35662.6 35982.5 36154.9 36933.8 37028.3 35130.1 35218.8 35319.0 35330.3 35678.0 27756.9 27880.6 29381.1 29752.9 30027.8 24265.8 24970.8 26063.2 26559.9 26571.5 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,980 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30539.97 Median:2289.33 stddev:93422.25 (4080.8%) stddev-sans-first:93656.78 07:13:14 INFO - 2015-12-17 07:13:14,981 DEBUG : BROWSER_OUTPUT: Values: 331.7 344.7 344.7 346.5 347.1 14480.7 14782.3 16708.0 17123.3 18213.3 14282.3 15607.4 17773.0 18147.9 18333.0 5400.6 5542.9 5546.2 5546.6 5558.7 6279.4 6471.7 6515.4 6519.9 6531.3 6440.6 6566.9 6780.6 6822.4 6834.4 6272.6 6759.0 6772.5 6776.5 6810.7 6178.9 6207.2 6224.5 6233.0 6245.6 20778.3 21445.7 21603.9 23876.2 23879.6 2132.0 2212.9 2286.0 2292.7 2352.9 14122.0 14188.8 14347.8 14735.5 14808.9 1986.4 2001.8 2049.9 2050.8 2080.4 58979.4 59231.4 60086.0 65006.3 69429.0 10141.7 10331.8 10485.6 10515.5 14669.0 13323.0 13352.6 13390.5 13452.5 13453.9 7057.6 7069.3 7075.3 7121.3 7156.5 6640.7 6683.3 6772.2 6809.2 6863.0 4540.6 4551.0 4630.7 4643.8 4678.7 1877.7 1896.9 1898.5 1920.6 1926.1 899.5 939.3 981.9 1032.6 1068.6 17190.9 17248.0 17389.3 17523.0 17567.6 919.8 920.3 926.8 986.3 1009.5 10034.5 10105.9 10214.2 10233.5 10244.5 538410.0 540110.0 585169.0 589639.0 601741.0 84545.6 85439.0 88202.1 88561.6 91082.0 1109.4 1123.3 1139.7 1149.4 1154.0 15560.1 15587.2 16170.4 16434.3 16767.8 35811.0 36161.3 36294.6 36306.8 36875.6 48106.6 48160.3 48254.0 49946.0 52639.0 9870.4 9887.7 9941.5 10002.6 10080.4 13730.5 17732.3 18081.9 18510.9 18565.7 14063.5 14314.6 14330.0 14585.3 14906.6 14408.4 14578.3 14625.9 14850.6 15253.5 14921.9 14976.4 15118.7 15334.9 15752.9 9735.8 9743.9 9794.8 9849.6 9896.8 10589.0 11981.8 14468.9 14501.7 15223.9 07:13:14 INFO - 2015-12-17 07:13:14,981 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,981 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5330.30 Median:5922.50 stddev:2763.97 (46.7%) stddev-sans-first:2756.78 07:13:14 INFO - 2015-12-17 07:13:14,983 DEBUG : BROWSER_OUTPUT: Values: 1506.1 1674.4 1744.4 1745.3 1746.7 6964.8 7165.1 7176.7 7706.2 7774.6 7818.1 7845.8 7857.3 7947.6 7956.9 2204.6 2237.6 2239.4 2241.8 2243.7 2233.8 2248.5 2275.2 2276.0 2288.3 2229.5 2246.5 2273.8 2282.2 2288.4 2225.4 2234.5 2247.4 2264.2 2274.6 2259.1 2282.0 2284.9 2285.3 2290.5 7740.2 7775.1 7839.9 7877.3 7907.4 4361.3 4412.8 4447.4 4474.3 4478.7 3027.7 3037.9 3106.8 3142.8 3148.4 1000.9 1019.6 1025.3 1029.7 1050.4 10272.5 10384.6 10400.6 10415.8 10448.3 3959.9 4003.3 4029.3 4031.1 4110.8 8584.1 8589.7 8614.0 8631.5 8644.3 4448.7 4453.9 4463.9 4464.0 4489.6 4041.0 4117.0 4148.9 4184.9 4190.0 3465.9 3496.7 3501.4 3502.9 3508.2 1041.5 1044.1 1045.5 1047.2 1052.1 1307.9 1311.5 1313.5 1320.3 1329.3 7287.2 7358.9 7413.7 7429.6 7446.9 465.9 471.9 472.5 475.4 497.6 5742.9 5777.7 5816.0 5825.3 5838.5 8563.9 8869.5 8999.5 9068.5 9173.4 8941.9 8956.0 8959.4 9001.1 9085.7 7007.3 7114.4 7179.5 7198.3 7235.8 6902.9 6938.1 6946.1 6967.7 6969.5 7921.8 8086.6 8169.7 8253.7 8329.8 8080.9 8187.2 8226.7 8298.5 8301.3 5824.8 6006.5 6166.8 6508.8 6568.5 7406.6 7432.7 7457.0 7467.1 7521.4 6920.0 7018.7 7129.1 7204.8 7252.4 6995.1 6998.9 7075.1 7099.6 7116.9 6965.2 6996.1 7056.7 7057.3 7083.1 6368.4 6377.6 6396.6 6407.0 6428.9 6444.8 6454.2 6469.7 6487.9 6633.9 07:13:14 INFO - 2015-12-17 07:13:14,983 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,983 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5658.77 Median:6388.80 stddev:1738.62 (27.2%) stddev-sans-first:1696.67 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: Values: 318.4 329.1 332.8 336.3 340.5 6331.1 6344.6 6345.0 6354.5 6464.1 6281.2 6290.8 6344.1 6386.5 6388.4 4787.4 4836.0 4849.8 4853.6 4859.6 4767.8 4819.3 4832.8 4834.8 4839.5 4709.3 4768.8 4769.4 4787.3 4812.1 4759.6 4770.6 4783.2 4786.4 4808.4 4116.4 4155.2 4157.1 4174.3 4175.7 6017.1 6024.3 6033.3 6039.6 6065.0 5459.8 5587.2 5605.7 5613.3 5626.7 6779.0 6799.6 6838.2 6842.9 6854.3 4567.3 4573.0 4584.9 4586.6 4589.3 6922.4 6924.4 6964.4 6965.2 6994.7 4682.2 4684.9 4703.5 4707.4 4714.5 4758.1 4761.8 4766.5 4770.2 4779.8 5527.2 5543.0 5555.7 5579.9 5589.2 6529.3 6681.1 6681.7 6681.7 6685.7 1640.0 1646.1 1686.6 1688.6 1698.4 1106.5 1107.6 1122.8 1123.2 1132.6 6341.2 6389.2 6475.2 6493.6 6513.4 6921.5 6977.4 6978.2 6979.8 6990.7 6351.4 6456.5 6464.5 6466.7 6475.4 3825.7 3870.8 3880.8 3882.4 3885.9 7226.8 7232.6 7292.1 7297.2 7305.3 7087.1 7186.5 7213.4 7244.3 7331.1 7287.2 7293.6 7328.6 7337.2 7350.4 7060.6 7111.1 7116.2 7116.8 7121.0 6794.7 7032.2 7038.9 7070.6 7072.6 7278.3 7283.4 7310.0 7314.2 7325.3 4731.5 4767.0 4774.2 4790.7 4795.6 6858.7 6890.2 7016.9 7131.8 7140.2 6835.6 6854.4 6893.9 6900.9 6930.5 6853.4 6885.0 6901.8 6904.5 6911.2 6625.2 6685.0 6739.7 6739.9 6754.7 6886.3 6907.3 6919.7 6922.4 6931.9 6750.9 6758.7 6760.4 6762.7 6790.5 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13395.62 Median:45768.54 stddev:15333.12 (33.5%) stddev-sans-first:15346.65 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: Values: 734.9 807.7 812.3 823.4 872.1 12964.5 13151.1 13216.1 13248.3 13301.2 12886.5 13528.1 13532.9 13582.5 13615.2 816.2 824.2 833.1 852.0 852.5 835.8 840.6 842.8 844.9 847.2 866.6 872.3 874.6 874.8 875.3 853.2 854.1 856.4 863.6 868.7 634.7 640.5 640.8 643.4 643.5 13212.4 13327.4 13429.1 13435.6 13464.0 12058.0 12110.8 12166.7 12224.4 12802.1 10299.8 10826.3 10914.2 11008.2 11056.3 3548.5 3590.7 3679.1 3723.8 3727.1 45093.8 46147.5 46638.3 46639.1 46810.3 9671.2 9690.6 9777.2 9787.3 9818.0 17324.5 17613.3 17643.7 17673.6 17707.7 7342.0 7431.8 7541.6 7544.5 7639.6 4264.2 4338.2 4349.4 4413.2 4446.1 3041.8 3074.5 3090.0 3094.6 3114.1 551.3 565.4 567.4 569.5 571.9 649.2 651.6 665.3 679.0 689.6 8116.1 8309.4 8464.3 8700.9 8801.4 641.1 650.4 659.7 675.1 731.3 3852.6 4002.2 4060.7 4078.7 4102.7 54142.7 54288.2 54547.0 54712.2 55923.7 49230.8 49551.5 49607.5 49700.0 50074.7 44829.6 45254.0 45640.5 45720.1 45817.0 8064.5 8322.8 8351.7 8375.4 8629.5 33304.7 33368.5 33387.0 34649.8 35272.8 37415.6 43835.0 43904.3 44011.0 44017.6 10046.5 10112.7 10228.1 10619.8 10710.8 10966.4 11066.3 11181.4 11254.9 11627.1 10441.1 10508.3 10633.1 11211.8 11251.9 10701.7 10706.7 10724.4 10937.3 11240.0 10350.0 10440.8 10795.9 11196.2 11570.2 8782.3 9535.3 9555.6 9847.8 10339.9 8907.0 9111.5 9136.3 9303.7 9517.4 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:13:14 INFO - 2015-12-17 07:13:14,984 DEBUG : BROWSER_OUTPUT: 07:13:15 INFO - 2015-12-17 07:13:15,599 INFO : Browser exited with error code: 0 07:13:15 INFO - 2015-12-17 07:13:15,618 INFO : Completed test dromaeo_css (00:18:30) 07:13:15 INFO - 2015-12-17 07:13:15,618 INFO : Starting test kraken 07:13:15 INFO - 2015-12-17 07:13:15,618 DEBUG : operating with platform_type : linux_ 07:13:15 INFO - 2015-12-17 07:13:15,618 INFO : Initialising browser for kraken test... 07:13:15 INFO - 2015-12-17 07:13:15,624 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphzpCmz/profile http://localhost:44616/getInfo.html 07:13:20 INFO - 2015-12-17 07:13:20,008 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:20 INFO - 2015-12-17 07:13:20,008 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:20 INFO - 2015-12-17 07:13:20,008 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:20 INFO - 2015-12-17 07:13:20,008 DEBUG : BROWSER_OUTPUT: __metrics 07:13:20 INFO - 2015-12-17 07:13:20,137 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] 07:13:21 INFO - 2015-12-17 07:13:21,003 INFO : Browser initialized. 07:13:21 INFO - 2015-12-17 07:13:21,004 INFO : Running cycle 1/1 for kraken test... 07:13:21 INFO - 2015-12-17 07:13:21,004 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphzpCmz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:32 INFO - 2015-12-17 07:13:32,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 143728640 07:13:32 INFO - 2015-12-17 07:13:32,878 DEBUG : BROWSER_OUTPUT: 07:13:35 INFO - 2015-12-17 07:13:35,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44616/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:35 INFO - 2015-12-17 07:13:35,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 143941632 07:13:35 INFO - 2015-12-17 07:13:35,981 DEBUG : BROWSER_OUTPUT: 07:13:38 INFO - 2015-12-17 07:13:38,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44616/tests/kraken/driver.html?testName=audio-dft) 07:13:39 INFO - 2015-12-17 07:13:39,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 144130048 07:13:39 INFO - 2015-12-17 07:13:39,204 DEBUG : BROWSER_OUTPUT: 07:13:42 INFO - 2015-12-17 07:13:42,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44616/tests/kraken/driver.html?testName=audio-fft) 07:13:42 INFO - 2015-12-17 07:13:42,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 07:13:42 INFO - 2015-12-17 07:13:42,651 DEBUG : BROWSER_OUTPUT: 07:13:44 INFO - 2015-12-17 07:13:44,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44616/tests/kraken/driver.html?testName=audio-oscillator) 07:13:45 INFO - 2015-12-17 07:13:45,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 139141120 07:13:45 INFO - 2015-12-17 07:13:45,205 DEBUG : BROWSER_OUTPUT: 07:13:47 INFO - 2015-12-17 07:13:47,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:48 INFO - 2015-12-17 07:13:48,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 139399168 07:13:48 INFO - 2015-12-17 07:13:48,006 DEBUG : BROWSER_OUTPUT: 07:13:51 INFO - 2015-12-17 07:13:51,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44616/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:51 INFO - 2015-12-17 07:13:51,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 140673024 07:13:51 INFO - 2015-12-17 07:13:51,593 DEBUG : BROWSER_OUTPUT: 07:13:54 INFO - 2015-12-17 07:13:54,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44616/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:55 INFO - 2015-12-17 07:13:55,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 141598720 07:13:55 INFO - 2015-12-17 07:13:55,565 DEBUG : BROWSER_OUTPUT: 07:13:58 INFO - 2015-12-17 07:13:58,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44616/tests/kraken/driver.html?testName=json-parse-financial) 07:13:58 INFO - 2015-12-17 07:13:58,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 141934592 07:13:58 INFO - 2015-12-17 07:13:58,985 DEBUG : BROWSER_OUTPUT: 07:14:00 INFO - 2015-12-17 07:14:00,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:14:01 INFO - 2015-12-17 07:14:01,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 07:14:01 INFO - 2015-12-17 07:14:01,128 DEBUG : BROWSER_OUTPUT: 07:14:02 INFO - 2015-12-17 07:14:02,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:14:03 INFO - 2015-12-17 07:14:03,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 141148160 07:14:03 INFO - 2015-12-17 07:14:03,550 DEBUG : BROWSER_OUTPUT: 07:14:05 INFO - 2015-12-17 07:14:05,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:14:06 INFO - 2015-12-17 07:14:06,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 141406208 07:14:06 INFO - 2015-12-17 07:14:06,235 DEBUG : BROWSER_OUTPUT: 07:14:08 INFO - 2015-12-17 07:14:08,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:09 INFO - 2015-12-17 07:14:09,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 141516800 07:14:09 INFO - 2015-12-17 07:14:09,315 DEBUG : BROWSER_OUTPUT: 07:14:11 INFO - 2015-12-17 07:14:11,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:12 INFO - 2015-12-17 07:14:12,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 142106624 07:14:12 INFO - 2015-12-17 07:14:12,552 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44616/tests/kraken/driver.html?testName=ai-astar) 07:14:14 INFO - 2015-12-17 07:14:14,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 141869056 07:14:14 INFO - 2015-12-17 07:14:14,503 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;111;113;112;123;110;111;110;112 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;125;154;166;128;147;148;125;172;133 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;161;162;163;161;162;164;168;166 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;72;72;124;72;76;71;72 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;93;93;145;96;94;145 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;110;111;110;109;111 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;146;146;146;147;149;148;146 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;95;98;96;96;96;97 07:14:14 INFO - 2015-12-17 07:14:14,507 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;59;61;61;60;58;60;63;57;58 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;67;67;68;69;68;69;68;69 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;84;92;85;86;86;85;85;87;86 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;121;115;127;134;124;125;138;127;124 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;154;153;154;159;155;164;152;162;154 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;68;73;71;68;70;65;64;65 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,727 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365254505__endTimestamp 07:14:14 INFO - 2015-12-17 07:14:14,508 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,511 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.32 (3.9%) stddev-sans-first:4.58 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 111.0 113.0 112.0 123.0 110.0 111.0 110.0 112.0 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:151.00 stddev:17.20 (11.4%) stddev-sans-first:17.65 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: Values: 158.0 125.0 154.0 166.0 128.0 147.0 148.0 125.0 172.0 133.0 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.40 Median:163.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 161.0 162.0 163.0 161.0 162.0 164.0 168.0 166.0 07:14:14 INFO - 2015-12-17 07:14:14,512 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:77.40 Median:72.00 stddev:16.43 (22.8%) stddev-sans-first:17.31 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 72.0 72.0 124.0 72.0 76.0 71.0 72.0 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.59 (24.0%) stddev-sans-first:23.45 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 93.0 93.0 145.0 96.0 94.0 145.0 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 110.0 111.0 110.0 109.0 111.0 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 07:14:14 INFO - 2015-12-17 07:14:14,513 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 146.0 146.0 146.0 147.0 149.0 148.0 146.0 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 95.0 98.0 96.0 96.0 96.0 97.0 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.77 (2.9%) stddev-sans-first:1.87 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: Values: 60.0 59.0 61.0 61.0 60.0 58.0 60.0 63.0 57.0 58.0 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 67.0 68.0 69.0 68.0 69.0 68.0 69.0 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,514 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:2.21 (2.6%) stddev-sans-first:2.33 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: Values: 87.0 84.0 92.0 85.0 86.0 86.0 85.0 85.0 87.0 86.0 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:6.44 (5.1%) stddev-sans-first:6.75 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: Values: 123.0 121.0 115.0 127.0 134.0 124.0 125.0 138.0 127.0 124.0 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:154.50 stddev:5.39 (3.5%) stddev-sans-first:4.27 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: Values: 145.0 154.0 153.0 154.0 159.0 155.0 164.0 152.0 162.0 154.0 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.87 (4.2%) stddev-sans-first:3.02 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 68.0 73.0 71.0 68.0 70.0 65.0 64.0 65.0 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:14 INFO - 2015-12-17 07:14:14,515 DEBUG : BROWSER_OUTPUT: 07:14:15 INFO - 2015-12-17 07:14:15,551 INFO : Browser exited with error code: 0 07:14:15 INFO - 2015-12-17 07:14:15,602 INFO : Completed test kraken (00:00:59) 07:14:15 INFO - 2015-12-17 07:14:15,602 INFO : Starting test v8_7 07:14:15 INFO - 2015-12-17 07:14:15,602 DEBUG : operating with platform_type : linux_ 07:14:15 INFO - 2015-12-17 07:14:15,602 INFO : Initialising browser for v8_7 test... 07:14:15 INFO - 2015-12-17 07:14:15,609 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2W47t5/profile http://localhost:44616/getInfo.html 07:14:20 INFO - 2015-12-17 07:14:20,038 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:14:20 INFO - 2015-12-17 07:14:20,038 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:14:20 INFO - 2015-12-17 07:14:20,038 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:14:20 INFO - 2015-12-17 07:14:20,038 DEBUG : BROWSER_OUTPUT: __metrics 07:14:20 INFO - 2015-12-17 07:14:20,135 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] 07:14:20 INFO - 2015-12-17 07:14:20,935 INFO : Browser initialized. 07:14:20 INFO - 2015-12-17 07:14:20,935 INFO : Running cycle 1/1 for v8_7 test... 07:14:20 INFO - 2015-12-17 07:14:20,936 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2W47t5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:14:32 INFO - 2015-12-17 07:14:32,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 143761408 07:14:32 INFO - 2015-12-17 07:14:32,787 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44616/tests/v8_7/run.html (next: http://localhost:44616/tests/v8_7/run.html) 07:14:54 INFO - 2015-12-17 07:14:54,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 138588160 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |0;Richards;166.333998669328 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.14675446848543 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1102.5358324145534 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |5;Earley;695.6219596942321 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 07:14:54 INFO - 2015-12-17 07:14:54,460 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: |8;Splay;694.0041350792557 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365294452__endTimestamp 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: Values: 166.3 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: Values: 188.1 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,461 DEBUG : BROWSER_OUTPUT: Values: 279.8 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: Values: 5202.1 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: Values: 1102.5 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.62 Median:695.62 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: Values: 695.6 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: Values: 12000.0 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: Values: 25200.0 07:14:54 INFO - 2015-12-17 07:14:54,462 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:694.00 Median:694.00 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: Values: 694.0 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: Values: 4840.6 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:54 INFO - 2015-12-17 07:14:54,463 DEBUG : BROWSER_OUTPUT: 07:14:55 INFO - 2015-12-17 07:14:55,335 INFO : Browser exited with error code: 0 07:14:55 INFO - 2015-12-17 07:14:55,347 INFO : Completed test v8_7 (00:00:39) 07:14:55 INFO - 2015-12-17 07:14:55,452 INFO : Completed test suite (00:20:10) 07:14:55 INFO - 2015-12-17 07:14:55,452 DEBUG : Working with test: dromaeo_css 07:14:55 INFO - 2015-12-17 07:14:55,452 DEBUG : Generating results file: dromaeo_css 07:14:55 INFO - 2015-12-17 07:14:55,453 DEBUG : Working with test: kraken 07:14:55 INFO - 2015-12-17 07:14:55,453 DEBUG : Generating results file: kraken 07:14:55 INFO - 2015-12-17 07:14:55,453 INFO : javascript benchmark 07:14:55 INFO - 2015-12-17 07:14:55,454 DEBUG : Working with test: v8_7 07:14:55 INFO - 2015-12-17 07:14:55,454 DEBUG : Generating results file: v8_7 07:14:55 INFO - 2015-12-17 07:14:55,454 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:55 INFO - 2015-12-17 07:14:55,501 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 07:14:55 INFO - 2015-12-17 07:14:55,501 DEBUG : process_Request line: dromaeo_css 7061.06 graph.html#tests=[[72,1,43]] 07:14:55 INFO - 2015-12-17 07:14:55,501 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:55 INFO - 2015-12-17 07:14:55,529 DEBUG : process_Request line: kraken 1522.70 graph.html#tests=[[232,1,43]] 07:14:55 INFO - 2015-12-17 07:14:55,529 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:55 INFO - 2015-12-17 07:14:55,567 DEBUG : process_Request line: v8_7 21108.67 graph.html#tests=[[230,1,43]] 07:14:55 INFO - 2015-12-17 07:14:55,569 INFO : javascript benchmark 07:14:55 INFO - 2015-12-17 07:14:55,571 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3158.9999999999995, 3179.9205019874516, 3204.4392231359534, 3227.6933691299328, 3234.8867789627366, 5287.762050707727, 5300.204969254613, 5362.731863406829, 5375.301210842595, 5375.3280839895015, 5393.568514518839, 5404.945950540494, 5420.295361602986, 5428.864278393042, 5505.119180931052, 4944.72803995781, 5036.697798132105, 5047.47001564836, 5110.054639891613, 5124.385073791132, 4863.36776219091, 4939.110960027194, 4967.031428871372, 4967.950320496803, 4970.353853998975, 4805.879853003668, 4910.950890491121, 4931.038447502757, 4934.358533390637, 5012.273220383042, 4905.092557876804, 4947.9505204947845, 4961.751912404401, 4970.055689419035, 5041.420236672793, 4946.826861059882, 4958.727270000149, 4960.379952505937, 4976.0, 5000.0999820032375, 5105.566026887719, 5141.922871156936, 5198.376194856603, 5206.661566998133, 5364.249005139283, 5782.739776710058, 5895.410458954113, 5898.882022359572, 5921.348651648315, 5933.317668468138, 5961.374055724174, 5963.642181469126, 5969.104634304846, 5976.223090998186, 5985.850353741148, 5315.28243687105, 5402.6758394496455, 5421.484958928895, 5427.050266203399, 5428.321459817523, 5999.6400215986305, 6043.395660433922, 6050.9394906050375, 6058.485028772516, 6139.10982907476, 5835.212246346774, 5854.736536855852, 5855.2973643163095, 5856.502197313276, 5865.794697185578, 5809.2738407699035, 5813.302403711582, 5859.765609375577, 5886.735096920649, 5932.2584676915385, 5822.970885145632, 5830.883382332415, 5847.26909136358, 5847.9415205848245, 5898.64608123514, 5834.5624078194305, 5841.7371218295275, 5842.094475356326, 5846.7076646167525, 5857.531397488191, 4392.736435813861, 4459.687821852504, 4479.820807167677, 4486.842960496367, 4521.864344069683, 4002.1195337025806, 4042.757434553936, 4055.3105971984833, 4060.4721386219603, 4096.26267271888, 5613.354464236665, 5619.634723742944, 5625.634333768292, 5626.831195064155, 5654.802081927113, 5732.971335143297, 5801.303843538718, 5861.736221870026, 5941.524678025748, 5985.910211346833, 5507.944920550824, 5575.581831362664, 5620.831375058755, 5629.831105066854, 5633.549316054706, 4886.828960986349, 5081.83117882889, 5092.2361645753435, 5120.615953803405, 5126.384833819965, 5920.437558431942, 5930.911036334458, 5993.640381577119, 6001.5798894077, 6038.607490513103, 5896.292444906639, 5944.048952167633, 5949.375315591974, 5957.880842383041, 5964.940350596438, 5906.970465147647, 6010.939890601213, 6018.909716354171, 6027.126066720389, 6027.879442411215, 5719.113537401709, 5771.797987070432, 5798.971005144947, 5816.069428891357, 5855.648661080349, 5891.528677705859, 5936.28764548257, 5936.8812623748145, 5939.762409503572, 5944.64332140073, 5628.718564071862, 5660.0, 5734.426557344233, 5791.305043394819, 5796.82609521715, 5733.483986441241, 5737.770489180386, 5749.8562535936935, 5783.652980821164, 5786.652800831964, 5638.2670252866865, 5657.5473962082115, 5697.23087383198, 5711.457411545896, 5713.800016999385, 5565.805196818092, 5733.369329373682, 5762.1068734346245, 5788.450097240755, 5895.322037965689, 5678.886422271614, 5680.573956953162, 5688.402717714746, 5689.2319536862, 5695.430456954271], "unit": "score", "name": "dojo.html", "value": 5402.201836369155}, {"lowerIsBetter": false, "replicates": [565.0540296507731, 600.0639003155077, 607.5564837668501, 609.1319869186408, 624.1854380034057, 34836.129096772594, 35186.824065879664, 35378.0, 35461.64538354616, 35529.822350888244, 41281.79359103208, 41568.37647435291, 41754.0, 41866.372004419885, 42010.78994605023, 8718.34612404069, 8897.110288971116, 8928.955355223216, 8935.821283574325, 8960.327975401839, 8691.695790647296, 8767.035626081126, 8768.824623507558, 8774.385792994493, 8787.428817126898, 8720.563971801415, 8794.51630160341, 8810.251128654072, 8813.118688131168, 8820.294376449869, 8699.739007829776, 8734.737957861305, 8743.038265790758, 8760.255378292853, 8764.342674299422, 8598.398112132154, 8695.130486951317, 8747.562621868945, 8764.693235736782, 8785.64857405703, 38369.0, 38503.0, 38596.0, 38818.641347552984, 39023.0, 3280.803151810899, 3336.8832090876704, 3400.6769356911054, 3440.4839274109086, 3628.38317486028, 29201.415971680446, 29357.559636605467, 29364.18715242203, 29647.0, 30072.548911766342, 3967.8016099194924, 3976.443297938291, 3989.6209860063245, 4001.4397984282223, 4073.287174744408, 239042.0, 240349.0, 240960.0, 242260.0, 243168.78415607987, 54888.176677349875, 55333.0, 55653.721731391895, 56205.0, 57511.0, 51615.48384516182, 51683.741581291855, 51782.74108629508, 51821.222681659805, 51825.22262166071, 13353.46586136563, 13530.458781648624, 13576.59270221895, 13584.388702508411, 13594.660133496543, 9964.451955142536, 9983.60065597368, 10010.799784004279, 10047.799044019224, 10058.899411005943, 18663.813361866207, 19261.0, 19435.416937491897, 19549.21803127859, 19588.314408995902, 7542.509736867086, 7573.35626471756, 7746.690132394641, 7784.571848548384, 7790.220977902164, 914.7027216154777, 928.2481190235931, 1039.0596510158318, 1081.3890152064216, 1135.7671677306132, 28055.0, 28535.19781990356, 28687.426251474855, 28789.136325910255, 28924.566131508043, 1000.7248006798043, 1007.6775431861734, 1091.3288327678579, 1131.2194585735815, 1165.9825102623468, 12436.316002619942, 13329.333533323295, 13422.798658020138, 13487.932560337333, 15181.0, 242854.0, 247951.0, 248094.0, 248584.0, 250037.0, 46976.5302346979, 47084.7645761769, 47272.290915636295, 47555.52444475511, 47582.28626570604, 1261.8422697162855, 1265.8923991460645, 1268.35313989864, 1283.525095714573, 1318.235423454394, 26464.470710586065, 28750.0, 28893.711062889102, 29046.41907161887, 29160.27099322534, 45255.0, 45314.54685453235, 45565.54434455613, 45639.0, 45758.084838303716, 280722.0, 281441.0, 282484.0, 282856.0, 283118.0, 29970.700292997662, 30297.394052119274, 30437.086887393412, 30625.549956003022, 30748.385032299677, 41389.793051034554, 42011.36982945197, 42317.0, 42357.15285694207, 42532.149357012066, 35497.467537986435, 35733.64266357303, 35813.28373432569, 36886.815565922, 36945.26109477849, 35662.64337356593, 35982.4602630966, 36154.90678016956, 36933.81533092317, 37028.259434810614, 35130.121746955505, 35218.82390588031, 35319.0, 35330.29339413249, 35678.0, 27756.861215693792, 27880.58179127274, 29381.11856644304, 29752.85123574368, 30027.849860750557, 24265.75734242635, 24970.77484138468, 26063.218103456926, 26559.867200663874, 26571.468570628866], "unit": "score", "name": "ext.html", "value": 17807.000712272726}, {"lowerIsBetter": false, "replicates": [331.6666749916334, 344.66395264617, 344.73799912066835, 346.5100069700288, 347.0802373709668, 14480.710385792278, 14782.334794934226, 16708.0, 17123.315067397303, 18213.27146914122, 14282.285885705725, 15607.375704971815, 17773.0, 18147.90926045371, 18333.0, 5400.594955378343, 5542.889142217154, 5546.168074788774, 5546.611737178399, 5558.666480011192, 6279.434850863444, 6471.741130354781, 6515.381038801306, 6519.902201466982, 6531.346865313478, 6440.581362211441, 6566.934330656704, 6780.627065511395, 6822.4200942919915, 6834.419074378684, 6272.5922815016875, 6759.019942108392, 6772.492063095263, 6776.491763117786, 6810.693518791666, 6178.938210617881, 6207.224096987877, 6224.533160013018, 6232.968835155841, 6245.6252624842655, 20778.272760453463, 21445.67831482529, 21603.891980540153, 23876.164334248217, 23879.641805372932, 2132.040581738224, 2212.904612216963, 2285.9657105143438, 2292.6904867842795, 2352.870592117433, 14122.0, 14188.787168192486, 14347.78478322826, 14735.484258050918, 14808.851911480855, 1986.4437957371815, 2001.8398528117716, 2049.893057748814, 2050.846186536001, 2080.44868109951, 58979.410205897824, 59231.40768592302, 60086.0, 65006.34993650098, 69429.0, 10141.695749127539, 10331.793364132825, 10485.580576776996, 10515.52680129396, 14669.0, 13323.0, 13352.599422017354, 13390.531331403354, 13452.461901524026, 13453.932730336286, 7057.647117644097, 7069.257727938595, 7075.327843854826, 7121.28787121294, 7156.463265255126, 6640.701168447432, 6683.331666833375, 6772.2211945625895, 6809.182898052265, 6863.039174515572, 4540.5913467787395, 4550.953280745447, 4630.699004564693, 4643.791029403685, 4678.69588476748, 1877.6714075037087, 1896.8577356698304, 1898.5253686578355, 1920.6254780317984, 1926.1139875657354, 899.4962820820231, 939.3424602778083, 981.9410835349902, 1032.5766435761452, 1068.5779117248644, 17190.91404542994, 17248.0, 17389.304427822746, 17523.0, 17567.64864702699, 919.8252332056887, 920.2775820980632, 926.786839027014, 986.2652324018652, 1009.4599389326675, 10034.498275086216, 10105.9494702526, 10214.182865370753, 10233.539490722935, 10244.487775611338, 538410.0, 540110.0, 585169.0, 589639.0, 601741.0, 84545.57727211325, 85439.0, 88202.11797882068, 88561.55719221491, 91082.0, 1109.351029647649, 1123.309164863603, 1139.7036770439745, 1149.4195431307303, 1153.9596114135966, 15560.066396016275, 15587.22063896778, 16170.434034808724, 16434.342626294816, 16767.832321676626, 35811.0, 36161.27677446384, 36294.637053630184, 36306.81846590856, 36875.63124368722, 48106.556803295956, 48160.27759583679, 48254.0, 49946.0, 52639.0, 9870.407775533491, 9887.653932112342, 9941.502924853872, 10002.599896004078, 10080.445575493419, 13730.45078196861, 17732.29070837152, 18081.909590451964, 18510.907445462686, 18565.72151417703, 14063.507777227747, 14314.570562883131, 14329.987603471045, 14585.270736462922, 14906.627334316729, 14408.351624176728, 14578.271086445848, 14625.85374146245, 14850.554483365517, 15253.466128685443, 14921.850781492047, 14976.400943962119, 15118.697626047198, 15334.9233253833, 15752.92123539375, 9735.756606084622, 9743.902560974582, 9794.75513112178, 9849.556769945513, 9896.752581185528, 10589.0, 11981.820272695742, 14468.927655361656, 14501.709965800414, 15223.92388038097], "unit": "score", "name": "jquery.html", "value": 9402.303377967284}, {"lowerIsBetter": false, "replicates": [1506.0812904128486, 1674.3637417781242, 1744.4243399678107, 1745.258265237274, 1746.6943284925135, 6964.8258793530185, 7165.068541089658, 7176.712931482747, 7706.190849960757, 7774.572398518093, 7818.140004599503, 7845.80385490363, 7857.292843644071, 7947.602619868998, 7956.880646790303, 2204.581129585382, 2237.574860776447, 2239.428945618865, 2241.7758224177614, 2243.6971008913833, 2233.810126139272, 2248.4940888300084, 2275.1695631094613, 2275.977240227593, 2288.336382449088, 2229.5429436965383, 2246.539459410825, 2273.795358417742, 2282.2354511238755, 2288.3592594073602, 2225.365770755327, 2234.497238121426, 2247.3932038349717, 2264.2188444986537, 2274.613315736329, 2259.085070546415, 2282.0073268128417, 2284.8743319117443, 2285.31440567829, 2290.4960908600083, 7740.225977402271, 7775.1447340792465, 7839.882401763978, 7877.330426913719, 7907.367410607138, 4361.323994780814, 4412.823487060514, 4447.355133505624, 4474.2841145416905, 4478.686491945533, 3027.7275045246033, 3037.9088627341216, 3106.8446577671025, 3142.795718278305, 3148.3703259347994, 1000.9249306301983, 1019.5819713917332, 1025.3386565665178, 1029.7477118106037, 1050.4380156616173, 10272.537735801907, 10384.636537721144, 10400.583976640924, 10415.791684166274, 10448.32085914413, 3959.940600890989, 4003.319435695939, 4029.2545879012478, 4031.07285324377, 4110.815013324408, 8584.141585841366, 8589.742307730778, 8614.0, 8631.525266110424, 8644.265237454887, 4448.733076015449, 4453.910921781546, 4463.906342945999, 4463.977680111579, 4489.595936365743, 4041.0, 4117.0, 4148.91702165955, 4184.91630167401, 4190.0, 3465.8613655454005, 3496.6852983231634, 3501.3697534443536, 3502.9299414011575, 3508.210652603195, 1041.4792603698152, 1044.0551301072542, 1045.451138152476, 1047.2459828923315, 1052.1057101463848, 1307.8888294494884, 1311.4819646239682, 1313.4614807928704, 1320.2540564580981, 1329.322045756671, 7287.198408175096, 7358.889616655754, 7413.666385012687, 7429.5542267464125, 7446.888296675555, 465.8765427161805, 471.8537253451441, 472.5274725274725, 475.35589276530493, 497.59197458084026, 5742.942570574241, 5777.653340799566, 5816.0, 5825.300963884276, 5838.481994681413, 8563.929508811398, 8869.467831929976, 8999.505027223435, 9068.501232432147, 9173.40372875761, 8941.865872011926, 8956.0, 8959.41763785352, 9001.099890011077, 9085.682001129928, 7007.334303241184, 7114.39527640146, 7179.456416870503, 7198.316159964795, 7235.819104522429, 6902.8619427610165, 6938.098047253825, 6946.0622815919205, 6967.65161741921, 6969.477289203229, 7921.801954951173, 8086.555239461651, 8169.673213071411, 8253.669853205805, 8329.833403331779, 8080.868678385148, 8187.222213889671, 8226.670933162606, 8298.54358010291, 8301.335893128657, 5824.767009319579, 6006.519478441802, 6166.784162554289, 6508.7721929734125, 6568.540202185801, 7406.555606663617, 7432.70269189248, 7456.96271518639, 7467.141278753013, 7521.435892308208, 6919.965400172967, 7018.719251229893, 7129.108861392326, 7204.783856484314, 7252.38354739853, 6995.055667485028, 6998.930010699828, 7075.115610548682, 7099.609521476162, 7116.893246601202, 6965.199002114821, 6996.090508233897, 7056.717731290691, 7057.329553692391, 7083.114610673666, 6368.42684158428, 6377.649229292433, 6396.616203027833, 6406.967965160145, 6428.935710642833, 6444.806655800334, 6454.225492940689, 6469.676516174267, 6487.935120648733, 6633.900491492535], "unit": "score", "name": "mootools.html", "value": 4319.539357133453}, {"lowerIsBetter": false, "replicates": [318.39346045782787, 329.06053218062425, 332.8036458489491, 336.26190511826553, 340.4977657954516, 6331.081993111002, 6344.587601805891, 6344.968275158623, 6354.459870910967, 6464.12734280872, 6281.214848143982, 6290.842728931779, 6344.1118243445835, 6386.521010924188, 6388.425041746254, 4787.40157480315, 4835.975820120894, 4849.757512124397, 4853.563179313861, 4859.635527335447, 4767.785449654756, 4819.253015782542, 4832.830850920219, 4834.830780922668, 4839.467658557556, 4709.317149013391, 4768.809247630091, 4769.427668679746, 4787.281907713836, 4812.133815913135, 4759.595434388081, 4770.61835053195, 4783.1868582341085, 4786.425628924517, 4808.350872632185, 4116.382542618601, 4155.231282212801, 4157.10622216225, 4174.290370636999, 4175.728577642443, 6017.097435384683, 6024.307204671475, 6033.336333003366, 6039.607425517372, 6065.02959526478, 5459.781608735646, 5587.161925711135, 5605.682664573822, 5613.270274864282, 5626.746796394172, 6779.017042528806, 6799.5920244785475, 6838.179418469816, 6842.931570684279, 6854.280300568468, 4567.269236922077, 4573.0, 4584.885377865547, 4586.633069354443, 4589.311603259504, 6922.376986071277, 6924.389700972017, 6964.373206411447, 6965.199002114771, 6994.720211191546, 4682.180618391768, 4684.929726054112, 4703.506131856174, 4707.364505791743, 4714.45783734868, 4758.072175925661, 4761.761911904391, 4766.451858036301, 4770.189067858472, 4779.761011949388, 5527.226188333637, 5543.002259593312, 5555.749991250404, 5579.9163012554845, 5589.217509548666, 6529.314421985718, 6681.098051763047, 6681.699323530453, 6681.732730690718, 6685.732570697215, 1639.9754003689955, 1646.1111000060073, 1686.6289416328389, 1688.5609741467306, 1698.405558054671, 1106.546316010448, 1107.6123356825208, 1122.814735568622, 1123.2361993844102, 1132.6375559820942, 6341.207349081365, 6389.169407977026, 6475.158229430144, 6493.610383377012, 6513.381228783258, 6921.515493915377, 6977.372036516738, 6978.197507286625, 6979.825504362431, 6990.685419156151, 6351.396617321347, 6456.547276862669, 6464.515161362917, 6466.741330346734, 6475.417212450902, 3825.6748176404762, 3870.806459677005, 3880.80595970206, 3882.4176373544196, 3885.941710874339, 7226.819329516804, 7232.602206878567, 7292.124945006633, 7297.197308296083, 7305.3425191732995, 7087.114110736158, 7186.4549121939035, 7213.350798428167, 7244.311790379906, 7331.083614548182, 7287.234840341794, 7293.598852063187, 7328.560286382834, 7337.229590892986, 7350.375218106521, 7060.611666358194, 7111.111111111111, 7116.181639111568, 7116.786496405116, 7120.964395177991, 6794.72821087151, 7032.1912980007955, 7038.859222815618, 7070.611116388648, 7072.575645461083, 7278.344948954407, 7283.417326613752, 7309.963450182715, 7314.158871729819, 7325.267473252632, 4731.479537250969, 4766.976165119152, 4774.236122220428, 4790.664653474223, 4795.64032697556, 6858.657067146523, 6890.20762612306, 7016.894746578703, 7131.750388736369, 7140.178879428932, 6835.555688880207, 6854.417374523221, 6893.862122757617, 6900.861982760216, 6930.5148639594745, 6853.383195512428, 6884.965575172092, 6901.75843845463, 6904.482163837632, 6911.17065952089, 6625.17185351831, 6684.966575167093, 6739.663016849236, 6739.898901516383, 6754.696038678173, 6886.311368863074, 6907.34380233877, 6919.654017299215, 6922.446204303745, 6931.861362772615, 6750.898736518858, 6758.695858686469, 6760.357766012221, 6762.661866906733, 6790.45676345901], "unit": "score", "name": "prototype.html", "value": 5081.765464215182}, {"lowerIsBetter": false, "replicates": [734.8750712378896, 807.7495976247363, 812.3054788156127, 823.3948048184579, 872.106091256462, 12964.48142074317, 13151.079424440293, 13216.14095083819, 13248.271345076017, 13301.201927884322, 12886.548970786025, 13528.120672156303, 13532.932335338333, 13582.52461163857, 13615.183089014667, 816.2286639126029, 824.2375802382787, 833.1293797981124, 851.9946463173453, 852.5438890193748, 835.7701632051204, 840.6385254340631, 842.7808769719886, 844.923956843884, 847.1867007672641, 866.6100254885296, 872.2672954718035, 874.623911717961, 874.8075423406872, 875.3434923807145, 853.2406158518924, 854.0989256334534, 856.3876828067899, 863.5897948474487, 868.6525389844049, 634.7238951056305, 640.5452128988424, 640.8173670503884, 643.3791391307363, 643.5495153392598, 13212.405441755143, 13327.400266988008, 13429.127106738031, 13435.596932092052, 13464.0, 12058.0, 12110.757784844342, 12166.695832604255, 12224.449899754532, 12802.103852730312, 10299.794004119876, 10826.296290741077, 10914.181436392302, 11008.174386920933, 11056.281341712764, 3548.520949671787, 3590.730695197871, 3679.0802299425145, 3723.757955732896, 3727.0868637183794, 45093.774531127136, 46147.53852461466, 46638.300425493646, 46639.06721865578, 46810.29784553235, 9671.177949874198, 9690.612375505041, 9777.241905027695, 9787.314887957917, 9818.018198180125, 17324.480265592054, 17613.295468181386, 17643.73534396985, 17673.646527069643, 17707.73438398425, 7342.0, 7431.777046688608, 7541.585212813348, 7544.47188696786, 7639.579823109671, 4264.168487145039, 4338.197433474817, 4349.434573505424, 4413.205622987829, 4446.088551846864, 3041.81749095055, 3074.4773388524004, 3089.9536506952413, 3094.5512900629283, 3114.0813460029344, 551.2723205368875, 565.4289167940327, 567.4467394290616, 569.4647031790104, 571.894199573072, 649.2378404403752, 651.569963823874, 665.2690704657408, 679.0018672551341, 689.5724650716588, 8116.066652335057, 8309.37679674027, 8464.298725863557, 8700.912990870136, 8801.383903126847, 641.131267133028, 650.4113331947343, 659.7492952678048, 675.1223409567641, 731.2687312687312, 3852.6339997700175, 4002.219567184371, 4060.6954478414236, 4078.7144899856726, 4102.671786257092, 54142.729286353315, 54288.185677214875, 54547.0, 54712.17931730948, 55923.72038139865, 49230.75384623054, 49551.50448495469, 49607.503924960285, 49700.0, 50074.749626251636, 44829.55170448254, 45254.0, 45640.5435945643, 45720.08559828785, 45817.0, 8064.475809072626, 8322.750317490485, 8351.665933362841, 8375.41372103947, 8629.525376104375, 33304.66695333113, 33368.49947250842, 33387.0, 34649.82675086709, 35272.82363588166, 37415.62584374121, 43835.0, 43904.34143487914, 44011.0, 44017.559824401345, 10046.497675116361, 10112.696619101438, 10228.130608898327, 10619.840702389316, 10710.839337409789, 10966.396848173426, 11066.289902247503, 11181.385023823768, 11254.94372528132, 11627.12234427894, 10441.112505437122, 10508.264421490423, 10633.096186823897, 11211.831822522832, 11251.943740281245, 10701.678949631523, 10706.73233169177, 10724.356538607708, 10937.343759374146, 11240.0, 10350.0, 10440.843387349043, 10795.892041079804, 11196.160287978597, 11570.157289927098, 8782.301802520522, 9535.284853636143, 9555.569999349907, 9847.753806154904, 10339.948300258451, 8907.0, 9111.498867562348, 9136.31477639193, 9303.72088837336, 9517.381370210915], "unit": "score", "name": "yui.html", "value": 6242.118949297504}], "name": "dromaeo_css", "value": 7061.054662095399}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 113.0, 112.0, 123.0, 110.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [158.0, 125.0, 154.0, 166.0, 128.0, 147.0, 148.0, 125.0, 172.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 161.0, 162.0, 163.0, 161.0, 162.0, 164.0, 168.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 72.0, 72.0, 124.0, 72.0, 76.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 77.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 93.0, 93.0, 145.0, 96.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0, 110.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 149.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 95.0, 98.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 61.0, 61.0, 60.0, 58.0, 60.0, 63.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 92.0, 85.0, 86.0, 86.0, 85.0, 85.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [123.0, 121.0, 115.0, 127.0, 134.0, 124.0, 125.0, 138.0, 127.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 153.0, 154.0, 159.0, 155.0, 164.0, 152.0, 162.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.2}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 73.0, 71.0, 68.0, 70.0, 65.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1522.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [695.6219596942321], "unit": "score", "name": "Earley", "value": 958.0821748251747}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [694.0041350792557], "unit": "score", "name": "Splay", "value": 117.42149056603775}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21108.665422516646}]} 07:14:55 INFO - RETURN: dromaeo_css: 7061.06 07:14:55 INFO - RETURN: kraken: 1522.70 07:14:55 INFO - RETURN: v8_7: 21108.67 07:14:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21108.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7061.06"}}} 07:14:55 INFO - Return code: 0 07:14:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:14:55 INFO - # TBPL SUCCESS # 07:14:55 INFO - Running post-action listener: _resource_record_post_action 07:14:55 INFO - Running post-run listener: _resource_record_post_run 07:14:56 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 86016; Write bytes: 519983104; Read time: 348; Write time: 509324 07:14:56 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 81920; Write bytes: 239083520; Read time: 336; Write time: 347540 07:14:56 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280899584; Read time: 12; Write time: 161784 07:14:56 INFO - Running post-run listener: _upload_blobber_files 07:14:56 INFO - Blob upload gear active. 07:14:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:14:56 INFO - Copying logs to upload dir... 07:14:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.623919 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-17 07:14:56.700445) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:56.704493) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010010 build_url: 'https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/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 07:14:56.756515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:56.756835) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450361291.24773-1338429353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:56.808032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 07:14:56.808447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 07:14:56.808827) ========= ========= Total master_lag: 0.77 =========