builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1451389649.05 results: success (0) buildid: 20151229013004 builduid: 1b53497eec0a45b19c6d4f697c5279cd revision: 31c27281f5184efd1ed58c892bc77a518536566d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.047362) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.048527) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.049012) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006342 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.096144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.096584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.119864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.120148) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.172043) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.172322) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.172651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.172956) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 03:47:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.8M=0s 2015-12-29 03:47:29 (83.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.286189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.286564) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.337135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.337595) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 31c27281f5184efd1ed58c892bc77a518536566d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 31c27281f5184efd1ed58c892bc77a518536566d --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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 03:47:29,541 truncating revision to first 12 chars 2015-12-29 03:47:29,542 Setting DEBUG logging. 2015-12-29 03:47:29,542 attempt 1/10 2015-12-29 03:47:29,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/31c27281f518?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 03:47:29,772 unpacking tar archive at: mozilla-inbound-31c27281f518/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.868378) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.868723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.878525) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.878806) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 03:47:29.879214) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-29 03:47:29.879505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:30 INFO - MultiFileLogger online at 20151229 03:47:30 in /builds/slave/test-pgo 03:47:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:47:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:47:30 INFO - {'append_to_log': False, 03:47:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:47:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:47:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:47:30 INFO - 'branch': 'Mozilla-Inbound', 03:47:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:30 INFO - 'config_files': ('talos/linux_config.py',), 03:47:30 INFO - 'default_actions': ('clobber', 03:47:30 INFO - 'read-buildbot-config', 03:47:30 INFO - 'download-and-extract', 03:47:30 INFO - 'populate-webroot', 03:47:30 INFO - 'create-virtualenv', 03:47:30 INFO - 'install', 03:47:30 INFO - 'run-tests'), 03:47:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:30 INFO - 'download_minidump_stackwalk': True, 03:47:30 INFO - 'download_symbols': 'ondemand', 03:47:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:30 INFO - 'installer_path': 'installer.exe', 03:47:30 INFO - 'log_level': 'info', 03:47:30 INFO - 'log_name': 'talos', 03:47:30 INFO - 'log_to_console': True, 03:47:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:30 INFO - 'opt_config_files': (), 03:47:30 INFO - 'pip_index': False, 03:47:30 INFO - 'sps_profile': False, 03:47:30 INFO - 'sps_profile_interval': 0, 03:47:30 INFO - 'suite': 'dromaeojs', 03:47:30 INFO - 'system_bits': '32', 03:47:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:30 INFO - 'title': 'talos-linux64-ix-021', 03:47:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:30 INFO - 'use_talos_json': True, 03:47:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:47:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:30 INFO - 'work_dir': 'build'} 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running clobber step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: clobber 03:47:30 INFO - rmtree: /builds/slave/test-pgo/build 03:47:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:47:30 INFO - Running post-action listener: _resource_record_post_action 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running read-buildbot-config step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: read_buildbot_config 03:47:30 INFO - Using buildbot properties: 03:47:30 INFO - { 03:47:30 INFO - "project": "", 03:47:30 INFO - "product": "firefox", 03:47:30 INFO - "script_repo_revision": "production", 03:47:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:47:30 INFO - "repository": "", 03:47:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:47:30 INFO - "buildid": "20151229013004", 03:47:30 INFO - "pgo_build": "True", 03:47:30 INFO - "basedir": "/builds/slave/test-pgo", 03:47:30 INFO - "buildnumber": 582, 03:47:30 INFO - "slavename": "talos-linux64-ix-021", 03:47:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:47:30 INFO - "platform": "ubuntu64_hw", 03:47:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:47:30 INFO - "branch": "mozilla-inbound", 03:47:30 INFO - "repo_path": "integration/mozilla-inbound", 03:47:30 INFO - "revision": "31c27281f5184efd1ed58c892bc77a518536566d", 03:47:30 INFO - "stage_platform": "linux64-pgo", 03:47:30 INFO - "builduid": "1b53497eec0a45b19c6d4f697c5279cd", 03:47:30 INFO - "slavebuilddir": "test" 03:47:30 INFO - } 03:47:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:47:30 INFO - Running post-action listener: _resource_record_post_action 03:47:30 INFO - ##### 03:47:30 INFO - ##### Running download-and-extract step. 03:47:30 INFO - ##### 03:47:30 INFO - Running pre-action listener: _resource_record_pre_action 03:47:30 INFO - Running main action method: download_and_extract 03:47:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:30 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:47:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json 03:47:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json 03:47:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:47:36 INFO - Downloaded 1302 bytes. 03:47:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:47:36 INFO - Using the following test package requirements: 03:47:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:47:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'jsshell-linux-x86_64.zip'], 03:47:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:47:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:47:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:47:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:47:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:47:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:36 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:39 INFO - Downloaded 23199705 bytes. 03:47:39 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 03:47:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:39 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 03:47:40 INFO - Return code: 0 03:47:40 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 03:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:40 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:43 INFO - Downloaded 23199705 bytes. 03:47:43 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 03:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:47:43 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 03:47:44 INFO - Return code: 0 03:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:44 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:45 INFO - Downloaded 11132270 bytes. 03:47:45 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 03:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:45 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 03:47:45 INFO - Return code: 0 03:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:45 INFO - https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/-fuTX7icTXCvl1YJEzw8Gw/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 03:47:48 INFO - Downloaded 54906192 bytes. 03:47:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:48 INFO - mkdir: /builds/slave/test-pgo/properties 03:47:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:47:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:47:48 INFO - Contents: 03:47:48 INFO - build_url:https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:47:48 INFO - Running post-action listener: _resource_record_post_action 03:47:48 INFO - Running post-action listener: set_extra_try_arguments 03:47:48 INFO - ##### 03:47:48 INFO - ##### Running populate-webroot step. 03:47:48 INFO - ##### 03:47:48 INFO - Running pre-action listener: _resource_record_pre_action 03:47:48 INFO - Running main action method: populate_webroot 03:47:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:48 INFO - '--tppagecycles', 03:47:48 INFO - '7'], 03:47:48 INFO - 'tests': ['tsvgm']}}, 03:47:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'tests': ['damp', 'tps']}, 03:47:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['damp', 'tps']}, 03:47:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:48 INFO - 'other': {'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'other_l64': {'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:48 INFO - 'ts_paint', 03:47:48 INFO - 'tpaint', 03:47:48 INFO - 'sessionrestore', 03:47:48 INFO - 'sessionrestore_no_auto_restore']}, 03:47:48 INFO - 'svgr': {'tests': ['tsvgx', 03:47:48 INFO - 'tsvgr_opacity', 03:47:48 INFO - 'tart', 03:47:48 INFO - 'tscrollx', 03:47:48 INFO - 'cart']}, 03:47:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['tsvgx', 03:47:48 INFO - 'tsvgr_opacity', 03:47:48 INFO - 'tart', 03:47:48 INFO - 'tscrollx', 03:47:48 INFO - 'cart']}, 03:47:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'tests': ['tp5o']}, 03:47:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'talos_options': ['--e10s'], 03:47:48 INFO - 'tests': ['tp5o']}, 03:47:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'talos_options': ['--xperf_path', 03:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:48 INFO - 'tests': ['tp5n']}, 03:47:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:48 INFO - 'talos_options': ['--e10s', 03:47:48 INFO - '--xperf_path', 03:47:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:48 INFO - 'tests': ['tp5n']}}, 03:47:48 INFO - 'talos.zip': {'path': '', 03:47:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:48 INFO - Running post-action listener: _resource_record_post_action 03:47:48 INFO - ##### 03:47:48 INFO - ##### Running create-virtualenv step. 03:47:48 INFO - ##### 03:47:48 INFO - Running pre-action listener: _resource_record_pre_action 03:47:48 INFO - Running main action method: create_virtualenv 03:47:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:47:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:47:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:47:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:48 INFO - Using real prefix '/usr' 03:47:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:50 INFO - Installing pip.................done. 03:47:50 INFO - Return code: 0 03:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47: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')]} 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:50 INFO - Using env: {'DISPLAY': ':0', 03:47:50 INFO - 'HOME': '/home/cltbld', 03:47:50 INFO - 'LANG': 'en_US.UTF-8', 03:47:50 INFO - 'LANGUAGE': 'en_US:en', 03:47:50 INFO - 'LOGNAME': 'cltbld', 03:47:50 INFO - 'MAIL': '/var/mail/cltbld', 03:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:50 INFO - 'MOZ_NO_REMOTE': '1', 03:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:50 INFO - 'NO_EM_RESTART': '1', 03:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:50 INFO - 'SHELL': '/bin/bash', 03:47:50 INFO - 'SHLVL': '1', 03:47:50 INFO - 'TERM': 'linux', 03:47:50 INFO - 'TMOUT': '86400', 03:47:50 INFO - 'USER': 'cltbld', 03:47:50 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:50 INFO - '_': '/tools/buildbot/bin/python'} 03:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:47:50 INFO - Cleaning up... 03:47:50 INFO - Return code: 0 03:47:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47: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')]} 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:47:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:47:50 INFO - Using env: {'DISPLAY': ':0', 03:47:50 INFO - 'HOME': '/home/cltbld', 03:47:50 INFO - 'LANG': 'en_US.UTF-8', 03:47:50 INFO - 'LANGUAGE': 'en_US:en', 03:47:50 INFO - 'LOGNAME': 'cltbld', 03:47:50 INFO - 'MAIL': '/var/mail/cltbld', 03:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:50 INFO - 'MOZ_NO_REMOTE': '1', 03:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:50 INFO - 'NO_EM_RESTART': '1', 03:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:50 INFO - 'SHELL': '/bin/bash', 03:47:50 INFO - 'SHLVL': '1', 03:47:50 INFO - 'TERM': 'linux', 03:47:50 INFO - 'TMOUT': '86400', 03:47:50 INFO - 'USER': 'cltbld', 03:47:50 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:50 INFO - '_': '/tools/buildbot/bin/python'} 03:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:51 INFO - Downloading/unpacking psutil>=0.7.1 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:47:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:52 INFO - Installing collected packages: psutil 03:47:52 INFO - Running setup.py install for psutil 03:47:53 INFO - building 'psutil._psutil_linux' extension 03:47:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:47:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:47:53 INFO - building 'psutil._psutil_posix' extension 03:47:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:47:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:53 INFO - Successfully installed psutil 03:47:53 INFO - Cleaning up... 03:47:53 INFO - Return code: 0 03:47:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:47:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:47:53 INFO - Using env: {'DISPLAY': ':0', 03:47:53 INFO - 'HOME': '/home/cltbld', 03:47:53 INFO - 'LANG': 'en_US.UTF-8', 03:47:53 INFO - 'LANGUAGE': 'en_US:en', 03:47:53 INFO - 'LOGNAME': 'cltbld', 03:47:53 INFO - 'MAIL': '/var/mail/cltbld', 03:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:53 INFO - 'MOZ_NO_REMOTE': '1', 03:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:53 INFO - 'NO_EM_RESTART': '1', 03:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:53 INFO - 'SHELL': '/bin/bash', 03:47:53 INFO - 'SHLVL': '1', 03:47:53 INFO - 'TERM': 'linux', 03:47:53 INFO - 'TMOUT': '86400', 03:47:53 INFO - 'USER': 'cltbld', 03:47:53 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:53 INFO - '_': '/tools/buildbot/bin/python'} 03:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:55 INFO - Installing collected packages: mozsystemmonitor 03:47:55 INFO - Running setup.py install for mozsystemmonitor 03:47:56 INFO - Successfully installed mozsystemmonitor 03:47:56 INFO - Cleaning up... 03:47:57 INFO - Return code: 0 03:47:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:47:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:47:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:47:57 INFO - Using env: {'DISPLAY': ':0', 03:47:57 INFO - 'HOME': '/home/cltbld', 03:47:57 INFO - 'LANG': 'en_US.UTF-8', 03:47:57 INFO - 'LANGUAGE': 'en_US:en', 03:47:57 INFO - 'LOGNAME': 'cltbld', 03:47:57 INFO - 'MAIL': '/var/mail/cltbld', 03:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:57 INFO - 'MOZ_NO_REMOTE': '1', 03:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:57 INFO - 'NO_EM_RESTART': '1', 03:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:57 INFO - 'SHELL': '/bin/bash', 03:47:57 INFO - 'SHLVL': '1', 03:47:57 INFO - 'TERM': 'linux', 03:47:57 INFO - 'TMOUT': '86400', 03:47:57 INFO - 'USER': 'cltbld', 03:47:57 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:57 INFO - '_': '/tools/buildbot/bin/python'} 03:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:00 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:01 INFO - Downloading docopt-0.6.1.tar.gz 03:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:01 INFO - Running setup.py install for blobuploader 03:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:48:02 INFO - Running setup.py install for requests 03:48:02 INFO - Running setup.py install for docopt 03:48:02 INFO - Successfully installed blobuploader requests docopt 03:48:02 INFO - Cleaning up... 03:48:02 INFO - Return code: 0 03:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48: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')]} 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:02 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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:48:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:48:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:02 INFO - Using env: {'DISPLAY': ':0', 03:48:02 INFO - 'HOME': '/home/cltbld', 03:48:02 INFO - 'LANG': 'en_US.UTF-8', 03:48:02 INFO - 'LANGUAGE': 'en_US:en', 03:48:02 INFO - 'LOGNAME': 'cltbld', 03:48:02 INFO - 'MAIL': '/var/mail/cltbld', 03:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:02 INFO - 'MOZ_NO_REMOTE': '1', 03:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:02 INFO - 'NO_EM_RESTART': '1', 03:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:02 INFO - 'SHELL': '/bin/bash', 03:48:02 INFO - 'SHLVL': '1', 03:48:02 INFO - 'TERM': 'linux', 03:48:02 INFO - 'TMOUT': '86400', 03:48:02 INFO - 'USER': 'cltbld', 03:48:02 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:02 INFO - '_': '/tools/buildbot/bin/python'} 03:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:02 INFO - Running setup.py (path:/tmp/pip-avkajr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:02 INFO - Running setup.py (path:/tmp/pip-8dm8Sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:02 INFO - Running setup.py (path:/tmp/pip-ykPVTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:02 INFO - Running setup.py (path:/tmp/pip-4DfsbI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Running setup.py (path:/tmp/pip-3t2zad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Running setup.py (path:/tmp/pip-FXQAie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Running setup.py (path:/tmp/pip-_lS9kC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:03 INFO - Running setup.py (path:/tmp/pip-YIsGN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:03 INFO - Running setup.py (path:/tmp/pip-zM6RE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:03 INFO - Running setup.py (path:/tmp/pip-ltrlik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:03 INFO - Running setup.py (path:/tmp/pip-OTeX_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:03 INFO - Running setup.py (path:/tmp/pip-gASNoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:03 INFO - Running setup.py (path:/tmp/pip-X1o4IT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:03 INFO - Running setup.py (path:/tmp/pip-ta2yEM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:03 INFO - Running setup.py (path:/tmp/pip-5ZEMM1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:03 INFO - Running setup.py (path:/tmp/pip-rI3qIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:03 INFO - Running setup.py (path:/tmp/pip-77HJM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:03 INFO - Running setup.py install for manifestparser 03:48:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozcrash 03:48:04 INFO - Running setup.py install for mozdebug 03:48:04 INFO - Running setup.py install for mozdevice 03:48:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozfile 03:48:04 INFO - Running setup.py install for mozhttpd 03:48:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozinfo 03:48:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozInstall 03:48:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozleak 03:48:04 INFO - Running setup.py install for mozlog 03:48:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for moznetwork 03:48:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozprocess 03:48:05 INFO - Running setup.py install for mozprofile 03:48:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozrunner 03:48:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozscreenshot 03:48:05 INFO - Running setup.py install for moztest 03:48:05 INFO - Running setup.py install for mozversion 03:48:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:05 INFO - Cleaning up... 03:48:05 INFO - Return code: 0 03:48:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:48:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:48:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:05 INFO - Using env: {'DISPLAY': ':0', 03:48:05 INFO - 'HOME': '/home/cltbld', 03:48:05 INFO - 'LANG': 'en_US.UTF-8', 03:48:05 INFO - 'LANGUAGE': 'en_US:en', 03:48:05 INFO - 'LOGNAME': 'cltbld', 03:48:05 INFO - 'MAIL': '/var/mail/cltbld', 03:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:05 INFO - 'MOZ_NO_REMOTE': '1', 03:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:05 INFO - 'NO_EM_RESTART': '1', 03:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:05 INFO - 'SHELL': '/bin/bash', 03:48:05 INFO - 'SHLVL': '1', 03:48:05 INFO - 'TERM': 'linux', 03:48:05 INFO - 'TMOUT': '86400', 03:48:05 INFO - 'USER': 'cltbld', 03:48:05 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:05 INFO - '_': '/tools/buildbot/bin/python'} 03:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:05 INFO - Running setup.py (path:/tmp/pip-K99WLy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 INFO - Running setup.py (path:/tmp/pip-FZqPET-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 INFO - Running setup.py (path:/tmp/pip-vwAfxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 INFO - Running setup.py (path:/tmp/pip-_Deo_n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:06 INFO - Running setup.py (path:/tmp/pip-yXKebw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:06 INFO - Running setup.py (path:/tmp/pip-zE8u8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:06 INFO - Running setup.py (path:/tmp/pip-blCAdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:06 INFO - Running setup.py (path:/tmp/pip-Grq1z3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:06 INFO - Running setup.py (path:/tmp/pip-Uz7wbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:06 INFO - Running setup.py (path:/tmp/pip-AOnlJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:06 INFO - Running setup.py (path:/tmp/pip-efBDD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:06 INFO - Running setup.py (path:/tmp/pip-H6MWwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:06 INFO - Running setup.py (path:/tmp/pip-EQLqv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:06 INFO - Running setup.py (path:/tmp/pip-6jlMBQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:06 INFO - Running setup.py (path:/tmp/pip-7KS1Vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 INFO - Running setup.py (path:/tmp/pip-BXaHWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 INFO - Running setup.py (path:/tmp/pip-4LpnLY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:08 INFO - Downloading blessings-1.5.1.tar.gz 03:48:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:08 INFO - Installing collected packages: blessings 03:48:08 INFO - Running setup.py install for blessings 03:48:09 INFO - Successfully installed blessings 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:09 INFO - Reading from file tmpfile_stdout 03:48:09 INFO - Current package versions: 03:48:09 INFO - argparse == 1.2.1 03:48:09 INFO - blessings == 1.5.1 03:48:09 INFO - blobuploader == 1.2.4 03:48:09 INFO - docopt == 0.6.1 03:48:09 INFO - manifestparser == 1.1 03:48:09 INFO - mozInstall == 1.12 03:48:09 INFO - mozcrash == 0.16 03:48:09 INFO - mozdebug == 0.1 03:48:09 INFO - mozdevice == 0.47 03:48:09 INFO - mozfile == 1.2 03:48:09 INFO - mozhttpd == 0.7 03:48:09 INFO - mozinfo == 0.9 03:48:09 INFO - mozleak == 0.1 03:48:09 INFO - mozlog == 3.1 03:48:09 INFO - moznetwork == 0.27 03:48:09 INFO - mozprocess == 0.22 03:48:09 INFO - mozprofile == 0.28 03:48:09 INFO - mozrunner == 6.11 03:48:09 INFO - mozscreenshot == 0.1 03:48:09 INFO - mozsystemmonitor == 0.0 03:48:09 INFO - moztest == 0.7 03:48:09 INFO - mozversion == 1.4 03:48:09 INFO - psutil == 3.1.1 03:48:09 INFO - requests == 1.2.3 03:48:09 INFO - wsgiref == 0.1.2 03:48:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:48:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:48:09 INFO - Using env: {'DISPLAY': ':0', 03:48:09 INFO - 'HOME': '/home/cltbld', 03:48:09 INFO - 'LANG': 'en_US.UTF-8', 03:48:09 INFO - 'LANGUAGE': 'en_US:en', 03:48:09 INFO - 'LOGNAME': 'cltbld', 03:48:09 INFO - 'MAIL': '/var/mail/cltbld', 03:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:09 INFO - 'MOZ_NO_REMOTE': '1', 03:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:09 INFO - 'NO_EM_RESTART': '1', 03:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:09 INFO - 'SHELL': '/bin/bash', 03:48:09 INFO - 'SHLVL': '1', 03:48:09 INFO - 'TERM': 'linux', 03:48:09 INFO - 'TMOUT': '86400', 03:48:09 INFO - 'USER': 'cltbld', 03:48:09 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:09 INFO - '_': '/tools/buildbot/bin/python'} 03:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 03:48:09 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 2)) 03:48:09 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 3)) 03:48:09 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 4)) 03:48:09 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 5)) 03:48:09 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 6)) 03:48:09 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 7)) 03:48:09 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 8)) 03:48:09 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 9)) 03:48:09 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:48:09 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 4)) 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 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 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:48:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:09 INFO - Using env: {'DISPLAY': ':0', 03:48:09 INFO - 'HOME': '/home/cltbld', 03:48:09 INFO - 'LANG': 'en_US.UTF-8', 03:48:09 INFO - 'LANGUAGE': 'en_US:en', 03:48:09 INFO - 'LOGNAME': 'cltbld', 03:48:09 INFO - 'MAIL': '/var/mail/cltbld', 03:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:09 INFO - 'MOZ_NO_REMOTE': '1', 03:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:09 INFO - 'NO_EM_RESTART': '1', 03:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:09 INFO - 'SHELL': '/bin/bash', 03:48:09 INFO - 'SHLVL': '1', 03:48:09 INFO - 'TERM': 'linux', 03:48:09 INFO - 'TMOUT': '86400', 03:48:09 INFO - 'USER': 'cltbld', 03:48:09 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:09 INFO - '_': '/tools/buildbot/bin/python'} 03:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:09 INFO - Downloading/unpacking jsonschema 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:48:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:48:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:11 INFO - warning: no files found matching '*.txt' 03:48:11 INFO - no previously-included directories found matching 'build' 03:48:11 INFO - no previously-included directories found matching 'dist' 03:48:11 INFO - no previously-included directories found matching '.git*' 03:48:11 INFO - Installing collected packages: jsonschema, functools32 03:48:11 INFO - Running setup.py install for functools32 03:48:11 INFO - warning: no files found matching '*.txt' 03:48:11 INFO - no previously-included directories found matching 'build' 03:48:11 INFO - no previously-included directories found matching 'dist' 03:48:11 INFO - no previously-included directories found matching '.git*' 03:48:11 INFO - Successfully installed jsonschema functools32 03:48:11 INFO - Cleaning up... 03:48:11 INFO - Return code: 0 03:48:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:48: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')]} 03:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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')]} 03:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff368339f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bda230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, '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': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:48: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', 'flake8'] in /builds/slave/test-pgo/build 03:48: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 flake8 03:48:11 INFO - Using env: {'DISPLAY': ':0', 03:48:11 INFO - 'HOME': '/home/cltbld', 03:48:11 INFO - 'LANG': 'en_US.UTF-8', 03:48:11 INFO - 'LANGUAGE': 'en_US:en', 03:48:11 INFO - 'LOGNAME': 'cltbld', 03:48:11 INFO - 'MAIL': '/var/mail/cltbld', 03:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:11 INFO - 'MOZ_NO_REMOTE': '1', 03:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:11 INFO - 'NO_EM_RESTART': '1', 03:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:11 INFO - 'SHELL': '/bin/bash', 03:48:11 INFO - 'SHLVL': '1', 03:48:11 INFO - 'TERM': 'linux', 03:48:11 INFO - 'TMOUT': '86400', 03:48:11 INFO - 'USER': 'cltbld', 03:48:11 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:11 INFO - '_': '/tools/buildbot/bin/python'} 03:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:12 INFO - Downloading/unpacking flake8 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:48:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:48:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:48:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:48:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:48:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:48:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:14 INFO - no previously-included directories found matching 'docs/_build' 03:48:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:48:14 INFO - Running setup.py install for pep8 03:48:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:14 INFO - no previously-included directories found matching 'docs/_build' 03:48:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:48:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:48:14 INFO - Cleaning up... 03:48:14 INFO - Return code: 0 03:48:14 INFO - Running post-action listener: _resource_record_post_action 03:48:14 INFO - Running post-action listener: _start_resource_monitoring 03:48:14 INFO - Starting resource monitoring. 03:48:14 INFO - ##### 03:48:14 INFO - ##### Running install step. 03:48:14 INFO - ##### 03:48:14 INFO - Running pre-action listener: _resource_record_pre_action 03:48:14 INFO - Running main action method: install 03:48:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:14 INFO - Reading from file tmpfile_stdout 03:48:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:48:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:48:14 INFO - Reading from file tmpfile_stdout 03:48:14 INFO - Output received: 03:48:14 INFO - Usage: mozinstall [options] installer 03:48:14 INFO - Options: 03:48:14 INFO - -h, --help show this help message and exit 03:48:14 INFO - -d DEST, --destination=DEST 03:48:14 INFO - Directory to install application into. [default: 03:48:14 INFO - "/builds/slave/test-pgo"] 03:48:14 INFO - --app=APP Application being installed. [default: firefox] 03:48:14 INFO - mkdir: /builds/slave/test-pgo/build/application 03:48:14 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'] 03:48:14 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 03:48:30 INFO - Reading from file tmpfile_stdout 03:48:30 INFO - Output received: 03:48:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:48:30 INFO - Running post-action listener: _resource_record_post_action 03:48:30 INFO - ##### 03:48:30 INFO - ##### Running run-tests step. 03:48:30 INFO - ##### 03:48:30 INFO - Running pre-action listener: _resource_record_pre_action 03:48:30 INFO - Running main action method: run_tests 03:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:48:30 INFO - Python 2.7.3 03:48:30 INFO - Return code: 0 03:48:30 INFO - grabbing minidump binary from tooltool 03:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:30 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 0x1c6c7f0>, '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 0x1bd82d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd8760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:48:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:48:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:48:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:30 INFO - Return code: 0 03:48:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:48:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:48:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:48:31 INFO - Return code: 0 03:48:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 03:48:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 03:48:31 INFO - Using env: {'DISPLAY': ':0', 03:48:31 INFO - 'HOME': '/home/cltbld', 03:48:31 INFO - 'LANG': 'en_US.UTF-8', 03:48:31 INFO - 'LANGUAGE': 'en_US:en', 03:48:31 INFO - 'LOGNAME': 'cltbld', 03:48:31 INFO - 'MAIL': '/var/mail/cltbld', 03:48:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:31 INFO - 'MOZ_NO_REMOTE': '1', 03:48:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:31 INFO - 'NO_EM_RESTART': '1', 03:48:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:48:31 INFO - 'SHELL': '/bin/bash', 03:48:31 INFO - 'SHLVL': '1', 03:48:31 INFO - 'TERM': 'linux', 03:48:31 INFO - 'TMOUT': '86400', 03:48:31 INFO - 'USER': 'cltbld', 03:48:31 INFO - 'XDG_SESSION_COOKIE': 'ccb4611811c763f2fad71465000001de-1451384038.797782-326035143', 03:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:31 INFO - '_': '/tools/buildbot/bin/python'} 03:48:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:48:31 INFO - mozversion application_buildid: 20151229013004 03:48:31 INFO - mozversion application_changeset: 31c27281f5184efd1ed58c892bc77a518536566d 03:48:31 INFO - mozversion application_display_name: Nightly 03:48:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:31 INFO - mozversion application_name: Firefox 03:48:31 INFO - mozversion application_remotingname: firefox 03:48:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:48:31 INFO - mozversion application_vendor: Mozilla 03:48:31 INFO - mozversion application_version: 46.0a1 03:48:31 INFO - mozversion platform_buildid: 20151229013004 03:48:31 INFO - mozversion platform_changeset: 31c27281f5184efd1ed58c892bc77a518536566d 03:48:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:48:31 INFO - mozversion platform_version: 46.0a1 03:48:31 INFO - using testdate: 1451389711 03:48:31 INFO - actual date: 1451389711 03:48:32 INFO - starting webserver on 'localhost:52774' 03:48:32 INFO - SUITE-START | Running 3 tests 03:48:32 INFO - TEST-START | dromaeo_css 03:48:32 INFO - operating with platform_type : linux_ 03:48:32 INFO - Initialising browser for dromaeo_css test... 03:48:32 INFO - TEST-INFO | started process 4931 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4u1TM1/profile http://localhost:52774/getInfo.html) 03:48:37 INFO - PROCESS | 4931 | __metrics Screen width/height:1600/1200 03:48:37 INFO - PROCESS | 4931 | colorDepth:24 03:48:37 INFO - PROCESS | 4931 | Browser inner width/height: 1024/697 03:48:37 INFO - PROCESS | 4931 | __metrics 03:48:38 INFO - PROCESS | 4931 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:48:38 INFO - PROCESS | 4931 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:39 INFO - TEST-INFO | 4931: exit 0 03:48:39 INFO - Browser initialized. 03:48:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:39 INFO - TEST-INFO | started process 5028 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4u1TM1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:51 INFO - PROCESS | 5028 | RSS: Main: 150016000 03:48:51 INFO - PROCESS | 5028 | 03:49:42 INFO - PROCESS | 5028 | 1451389782527 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:51:52 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52774/tests/dromaeo/cssquery-ext.html) 03:51:53 INFO - PROCESS | 5028 | RSS: Main: 267862016 03:51:53 INFO - PROCESS | 5028 | 03:54:56 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-ext.html (next: http://localhost:52774/tests/dromaeo/cssquery-jquery.html) 03:54:56 INFO - PROCESS | 5028 | RSS: Main: 233451520 03:54:56 INFO - PROCESS | 5028 | 03:57:58 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52774/tests/dromaeo/cssquery-mootools.html) 03:57:59 INFO - PROCESS | 5028 | RSS: Main: 233025536 03:57:59 INFO - PROCESS | 5028 | 04:01:01 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52774/tests/dromaeo/cssquery-prototype.html) 04:01:01 INFO - PROCESS | 5028 | RSS: Main: 215236608 04:01:01 INFO - PROCESS | 5028 | 04:04:04 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52774/tests/dromaeo/cssquery-yui.html) 04:04:04 INFO - PROCESS | 5028 | RSS: Main: 219725824 04:04:04 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | Cycle 1(1): loaded http://localhost:52774/tests/dromaeo/cssquery-yui.html (next: http://localhost:52774/tests/dromaeo/cssquery-dojo.html) 04:07:07 INFO - PROCESS | 5028 | RSS: Main: 224645120 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | __start_tp_report 04:07:07 INFO - PROCESS | 5028 | _x_x_mozilla_page_load 04:07:07 INFO - PROCESS | 5028 | _x_x_mozilla_page_load_details 04:07:07 INFO - PROCESS | 5028 | |i|pagename|runs| 04:07:07 INFO - PROCESS | 5028 | |0;dojo.html;3198.7600929930254;3251.9349613007757;3298.356820420019;3307.503874418838;3316.8839090631827;5307.708076055816;5387.272718183044;5447.945520544793;5450.836474905749;5460.754266058022;5426.21319908613;5536.446355364462;5579.553635709143;5604.299462567179;5606.046972014757;4941.234108713137;4974.403071631409;4989.75051247438;5016.097102521545;5037.672551284155;4840.419149702041;4990.226514890198;5005.124103281929;5046.495350464943;5064.56951159152;4900;4967.428745694219;4998.800047998076;5007.874803129915;5016.673916195436;4951.925721114186;4952.752362381866;4955.281484184773;4958.87602809929;4985.975070124662;4921.827736029221;4934.309196712463;4934.5312195341385;4935.851924442272;5022.096022715909;5355.758990845421;5379.784808607651;5401.891962160735;5421.783128674848;5460.481254280837;5904.852378690524;5916.201312822757;5920.615160014629;5928.7924922627935;5936.5547583931375;5883.6469811811;5956;5972.283326000907;5983.491403230731;6005.669688167149;5452.482014208644;5484.478974497416;5488.423715509894;5531.889362212773;5581.553475721973;6070.544709146831;6085.174537170622;6087.995480745627;6134.386561343919;6151.108089327023;5674.347450043216;5715.057015592464;5956.5532585055425;5958.582899197101;5970.432808883149;5902.026165682614;5924.822255332347;5996.190514280604;5998.790042348497;6043;5876.206712093898;5914.615549989323;5917.378675239038;5917.408259174048;5921.881562368729;5879.206307148565;5919.792807251725;5928.851778705481;5929.673867937218;5993.820185394445;4495.21333766596;4506.7070640408265;4578.5650363215445;4578.88552786183;4589.472210695746;4034.798260086984;4059.4925634295714;4061.0659548304056;4085.6935729820384;4093.5087789465456;5516.3380394352935;5575.721213939287;5586.994341018656;5589.944100559023;5630.746616402272;5855.795047173328;5900.350961394243;5918.3693820364915;5967.104934259809;5971.552133589998;5519.39286678465;5522.972385138129;5525.033119204123;5526.4197259288;5529.861753456195;5085.516875896784;5090.9236361454605;5095.719735414514;5096.082705113041;5140.717260550631;5935.2877654681715;6040.939590604125;6048.727807248684;6057.909131363033;6097.639735507201;5991.191189189403;5992.940070599413;5996.850078748066;6004.039353703386;6020.969895150496;6062.393760623902;6120.17377654011;6123.632582045091;6133.693315334126;6137.508999280136;5809.680467574324;5850.297964244318;5897.616654917417;5927.229460170151;5931.021381472009;5835.4748072673665;5844.649321040752;5864.706764661664;5887.470127688357;5888.499477544457;5678.914816277842;5680.914786278292;5688.886222275614;5692.0608099663095;5733.483986441241;5623.409541998195;5629.605927585029;5661.603687741818;5683.119116536944;5847.678377689268;5639;5661.575381846295;5668.26312579362;5673.290838645169;5707.543396528351;5799.3040835100055;5845.357010728731;5855.268091488564;5858.443447872445;5906.645601263938;5633.549316054788;5728.2266893970445;5739.368669446441;5740.512056475246;5741.569382296261 04:07:07 INFO - PROCESS | 5028 | |1;ext.html;518.949128015768;525.2252926932772;527.3961314295132;550.790699534177;581.2153592649926;27254.863725681367;27857.58213626797;35667.64332356676;35800.82099589498;35962.28075438496;38444.42333365002;38890;38913.416298755474;38956.22087558247;38991.80504097475;7333.156686980986;8296.336293096552;8518.935133108362;8574.185452382013;8610.612522436473;7565.432592555553;7698.076230852305;7701.114371847225;9934.403935763878;10132.138768204675;9884.01159884013;9974.601015959353;9976.251781116409;9980.30137890348;9984.351017183895;9781.755456113655;9842.26183036268;9879.901200988006;9983.850242246299;9998.600055997751;7384.889226661604;7572.39420846331;9803.411795292306;10045.497725113788;10058.295919285652;35883.28233435316;36211.4568281476;36220.45669314962;36228.63771362305;36304.63695363065;2720.578310361897;2736.3979924416594;2742.081402730088;2838.262051866509;3146.5909431773953;27863.860680696467;28235.29411764702;29118.417631647248;29207.269818254714;29539.261518461997;3497.3879571075213;3506.2286297014616;3512.947305790415;3620.7827530348263;3661.7986010769396;266031;266259;266334;266520;266750.6662466695;47398.28902566464;48309.067637294116;53098.469015309354;53102;53445.46554534483;58062.419375806545;58961.41038589645;59145;59174.40825591775;59200.40799592035;14520.709585808436;14838;14845.109293442429;14845.554633361016;14852.777208341884;10751.78496430067;10776.19178561611;10777.78444431107;10809.35143891369;10813;17715;17772.644547108986;17821.7326740099;18214.90892545529;18336.174872130785;6946.409555187764;7233;7236.529625574321;7256.12926448819;7296.16094149169;907.7276816954887;945.8959514453404;1027.9074883260541;1067.9038886500252;1073.4042606353394;27484.862575686995;28536.571951420745;28971.42057158845;29502;30159.729718923605;1012.6303899076784;1016.7305663999047;1031.5203430404897;1038.413296487482;1131.530414877833;12754.61736147917;13252.73494530104;13320.93339533296;13362.933185334012;15048.473303434328;314678;316930;318251;318436;318683;51197.232041519404;51231.74384128056;51259.74370128125;51316;51328;1348.5766685272322;1352.6145048661085;1369.6096612465399;1375.3329635127157;1375.8417781955204;27510.862445687642;28439.28901777472;28732.42535149327;28748.712512874605;28944.855275723487;44333;44684.776576116914;44728.55271447374;44750.3287450682;44781.55218447774;238390;273363;280146;379671;382875;28317.575236371882;28332.291692707848;28433;28442.857785710938;28703;39081.41377879391;39854;40772.79613601913;40831.59168408278;41006.79496602617;34085.65914340825;34103.31793364169;34329;34525;34931;34526.82736586301;34602.48096278608;34687.65312346945;34927.82536087303;35051.29897402089;32921.67078329186;33857.15357116092;34211.31577368489;34305.65694343125;34737;30053.398932021675;31297.8435107823;31702.841485793346;31767;31811.68188318087;23747.287581372588;23785.762142379048;23982.28053158408;24178.87910560436;24258 04:07:07 INFO - PROCESS | 5028 | |2;jquery.html;353.80187095226677;357.7174032514314;357.8264541697277;361.60223753870747;362.791394947905;14097.154170749736;14497.782533262009;15356.385744570218;15629.921850390747;16293.674126517462;14782.704345913075;16103.758443623356;16194;16195.190240487958;16541.83458165421;5144.0740666679885;5268.657537260085;5281.181416880389;5283.788648454077;5286.31277933868;3990.9600903990877;4115.835366585333;5181.0674078665825;5226.7909283628605;5708.08670612702;5719.485246327829;5759.510441612468;5762.02045652238;5763.481286684198;5764.164196191549;5621.550275977912;5743.339515955677;5754.424557544254;5754.539636829044;5777.1623114648355;5026.2711906773675;5029.069622119883;5059.772310246048;5060.84817455477;5066.69599824008;17567.03381314027;18226.27094916202;18881.90559047196;20916.267930622354;21063.789362106338;2012.5874195789827;2133.7439507259073;2292.1289909834322;2383.2611890314056;2383.8569685818907;9137.862932056025;9244.168024877794;9436.292278079172;11211.887881121247;12290.815637765441;1858.4610462965725;1902.838258748008;1932.9033548322527;1975.6443840108918;1995.7106219598222;57350.426495735344;57980.130298045144;62146;64872;64898.67550662217;9517.952410237904;9826.557804898797;10015.025025124576;10030.598776049022;10120.342177758423;13056.543020994219;13071.41178646963;13077.346132693518;13082.411291491906;13090;6839;7258.346748792528;7498.775036748906;7550.282723141293;7562.697492100255;7374.889376659355;7378.372838308804;7378.557286562824;7430.554166749904;7436.96281518589;4203.70574059819;4247.830086796555;4266.4240327556;4277.272863613193;4278.122984788173;1639.9098049607387;1660.966780664404;1669.8246684097994;1716.1590820498116;1782.9375971840923;439.34318194299726;444.4311281559609;852.9317654587618;945.8817647794026;1005.9094681478556;10458.895411045793;10748.946255268673;10945.890541094646;11052.336859788438;11178.552857885594;407.7594219410503;431.2776100032433;442.7343593843668;442.9136318417878;449.97525136117827;5478.616496845262;5644.153376993484;5690.118031705092;5745.569082318759;5772.740226689809;518439;519173;530394;532129;544045;80072.19927800764;81884.18115818885;82261.58869205616;82422;82853.58573207216;481.03072309296795;481.7687509995222;481.8795301174706;482.35364611420863;482.8816939849689;9800.558974846292;9866.654667086617;9924.354916930377;10039.69880903574;10075.899241007495;32360.190995225308;32478.35043299168;33060.66939330672;33075.33849323048;34444;39013.41479877747;45226;45774;48371.758141209066;50222;9132.315076369432;9418.670346537838;9431.292653050912;9461.432314061178;9467.289953253396;10660.46697665129;10890.727731806452;10916.508757106109;10977.560897564008;11001.61494347694;9634.373765705206;9681.983391744046;9905.207583393456;9935.950320248352;9971.800563988825;9967.302288839712;10044.54799534008;10047.397156170653;10221.23340749432;10486.842697359698;8601.870971935552;8907.688230911886;10466.476676166314;10574.577016919236;10619.203559732896;14582.708345832812;14711.33798979027;14728.852711472748;15126.697466050837;15257.923710381378;15603.921980390025;15718.13550254747;15812.60468488251;15816.60458488501;15890.68218635644 04:07:07 INFO - PROCESS | 5028 | |3;mootools.html;1334.072819390524;1363.5295822941089;1365.460643045997;1484.3839806480312;1752.675754985327;6879.312068793118;7481.812954676129;7627.3898088152955;7631.656575454104;7632.236776322365;7423.22056184101;7580.317771400573;7619.42854285928;7621.847563048749;7637.045369328834;2028.6449871272541;2071.4510654676524;2076.480879780055;2226.2096955580737;2271.0461606125386;2274.590573696734;2306.215886598556;2323.907043718249;2324.2794733632545;2324.5583339165505;2278.9544209115807;2282.338121944634;2353.0587764894008;2354;2354.3172479980785;2262.7058482397347;2266.9319920402413;2283.3264187064774;2346.1084787780705;2346.120204923154;2280.270313499681;2294.128231272106;2345.870977096259;2346.835721499496;2349.8707571083582;7600.125985511681;7685.807854803618;7692;7785.221477852226;7795.844083118306;4730.0776348612035;4843.07981483517;4843.975780121112;4845.53967373099;4853.927191092136;2870.0959197852817;2919.605853209811;2920.73713365796;2962.6000489934013;3116.1586371679746;863.1972265792873;878.3456325037823;892.683097500391;893.9955300223522;1735.3492440334874;10059.849102263472;10135.594576216943;10184.28709990301;10198.286119971604;10200.94899525505;4239.97880010598;4350.390945267665;4368.126374725068;4374.431323927933;4466.972596302803;8930.776730581787;9048.276137908952;9050.366474346733;9077.319201059814;9080.636774529077;4735.076660051326;4739;4759.547842954914;4777.641676874248;4784.378030856036;4312.310030395121;4329.675274354436;4331.848385306562;4333.349997500401;4362.71642343253;3537.6285490023693;3596.604373518911;3617.439296908983;3764.661180493769;3836.4245363195746;1231.384307846077;1248.6566194296458;1259.1500737002486;1261.1802328486558;1264.342541878218;1002.6741309074434;1003.5283416794096;1041.4324193314662;1073.8174510333263;1238.5417395563518;6802.319768023158;6840.521163518605;6843.965780171067;6848.623325717033;6859.279775623588;613.3896772711181;621.9191505104308;624.5815303746501;628.5317438508249;759.673340463606;5467.343918729698;5585.1901474286005;5590.077637189818;5600.971995139998;5607.243022191952;8889.066648001995;8992.775180620536;9030.096990301048;9051.185393314634;9149.542522873962;9144.497052662035;9302.627894884128;9325.253979681609;9347.719568412958;9349.579268932914;7006.894896576556;7034.929650703428;7178.102737157856;7186.317299856505;7188.137423509317;7100.502964792415;7131.679074441558;7155.069840920647;7159.427245820218;7167.569945803269;8142.715004974797;8371.204735550113;8455.577221139041;8589.484630921916;8589.484630922165;8557.35819813504;8604.655813767378;8736.650533978569;8747.475151490677;8748.300135988979;6666.699998499982;6744.258131605421;6768.052472653734;6779.796606101825;6786.355296246848;6647.60114393138;6789.219239787488;7096.787096387116;7273;7280.854382912418;6706.564073335413;6713.6307503085845;6810.489213309121;6872.587644741331;6916.896246556205;6609.405153536205;6656.36764507371;6686.1642294713165;6700.49746269022;6869.793906182823;6565.376289252514;6772.5936443813525;6778.627175505395;6797.796066118024;6799.89800153008;6227.034809604518;6245.375462453719;6246.46905013079;6299;6332.018537126753;6257.812265632038;6296.748130074929;6307.337729538516;6309.873802524015;6311.053341998737 04:07:07 INFO - PROCESS | 5028 | |4;prototype.html;331.54081596988163;336.099253999282;338.2676505365883;344.44544283703226;345.7804294273136;5843.444872737083;5991.640501569909;6005.579609427336;6020.819375418733;6091.45176934077;5779.971100144493;5952.970235148829;5964.910526342108;5971.611845230057;6001.06983417571;4630.050839577879;4634.606058485025;4635.072985402916;4640.141573808839;4644.047970166124;4391.670624703144;4476.440444944382;4494.348319493672;4602.355670206174;4624.491305956342;4549.61328287096;4580.0610874770755;4589.196890544158;4589.885252868671;4617.6536759742985;4583.243764778807;4590.632749380058;4597.057603191338;4597.2874204498185;4603.562661547147;4031.072853243741;4035.899102522431;4043.433919251307;4054.878353649395;4056.614621610972;5575.776968921279;5623.8594035149035;5644.971775141098;5668.348139963916;5719.885602287973;5332.093544097513;5335.706536140511;5341.2255222992835;5342.599305052097;5364.409914909357;6128.111423843562;6358.586691865014;6361.8409539761415;6362.331955144689;6364.363563643645;4313.1804957058375;4367.58507941745;4409.647228221735;4431.667624928144;4437.46750389952;6547.803565892983;6603.735850565971;6633.834154146137;6642.80071597848;6646.302138275508;4494.775261236925;4502.819887204475;4509.278515437514;4509.751963642031;4511.548845115528;4456.22016147173;4542.568455996675;4554.681172317906;4556.612687921497;4569.040501494724;5224.738763061831;5227.581793456515;5231.790728370898;5237.973810130925;5253.868653283622;6360.936390636127;6376.426121649074;6378.872422551523;6381.234251889803;6383.234011918599;1594.936202551908;1611.2829790743242;1621.2704283072665;1625.0412256768564;1625.8455446732542;1066.7546464313252;1074.7742973975396;1096.6161843354762;1098.6045023791428;1112.1158678850334;6039.849003774941;6051.394860513913;6062.818115456544;6067.453929146398;6073.544484163705;6538.248101468392;6542.869142617121;6544;6546.9345306547275;6565.770198043046;5821.970890145607;5922.170896074553;5926.822195334147;5927;5937.851553711105;3536.5225694531423;3564.590072141737;3565.607783143852;3567.928641427157;3568.91077723059;6596.637184954873;6606.86786264272;6607.603543787388;6617.139771829631;6622.37087476689;6567.2447668518735;6601.966990165019;6602.570832895846;6617.305182955816;6705.865882682319;6571.605703657796;6693.631850248185;6731.360520750619;6749.966250168718;6752.662366881538;6278.874422511615;6446.258680251831;6570.310117437792;6577.112089867998;6577.704003319766;6335.619862808247;6434.64609446485;6495.480361571157;6514.902276465762;6536.575122617015;6772.424343930821;6814.454843612598;6815.318468153145;6821;6823.55646882951;4383.868483945486;4421.624161946271;4466.553344665507;4469.642428605769;4469.798859051415;6614.933850661624;6629.07192992991;6630.071789949315;6641.601503909781;6642.335766423513;6348.936510634834;6431.196100487439;6435.967820160869;6440.227172739301;6443.420092191725;6308.747650094128;6351.1425957496995;6351.301356850835;6412.006139048455;6419.133416988647;6243.719032643451;6264.2796078451565;6287.559870809182;6293.615404610979;6296.5277604178955;6441.420272175526;6446.807340641996;6448.9032664511005;6455.515836312389;6465.062565928009;6137.35557766446;6234.407731265523;6286.371362863677;6302.117703521419;6315.652639104894 04:07:07 INFO - PROCESS | 5028 | |5;yui.html;604.5073265288792;618.1500436899266;662.9602223866568;678.318290118431;695.7147569496506;12152.69618259544;12400.069994750385;12448.377581120953;12475.750484990294;12499.250044997296;11087.05760010398;11163.274387164829;11218.775624487505;11254.49354779035;13920.651983700413;805.923437273458;817.0195765081896;819.3527113580294;820.4461988157999;820.4625969989667;643.3437893348805;678.3453966921919;761.5621017914722;813.0040700142308;814.4054839966827;830.1822704635958;837.1252041616495;840.369722707969;849.4818160921864;858.0347109501811;657.2474516678424;838.5471845203583;839.7061028639988;840.1850205300848;840.2479780596393;508.77359574989146;579.3945327133156;619.5848781316529;626.6302881300055;630.6184758221256;11486.368249746261;11597.6520704379;11673.708157296136;11676.941615291955;11711.297322160697;10992.230543861933;11248.156388270912;11337.773244535145;11531.538738450452;11799.587014454539;8460.407771456;8789.121087891224;9015.819683606356;9100.362974591715;9339.299552533586;3405.7956522608724;3423.298223864102;3479.1128262292955;3480.547528821237;3485.337785820686;48247;48387.51612483865;48477;48593;49208.015839683365;9109.81780364389;9234.722958311128;9240.168384845396;9270.44377337362;9396.765080872896;16383.180840957904;16615.750763738553;16636.334546618;16645;16648.25082871274;6377.904331435032;6495.512836537278;6535.771248006392;6550.475961923034;6614.173228346457;4061.329880569732;4064.207479541461;4083.0404854859084;4089.9591004090175;4155.896102597399;2725.890964361443;2755.0632784853246;2756.944861102767;2764.5853122031453;2792.7905407094145;547.887683024979;550.3698265485996;558.3997203006784;560.8709996700782;561.8483009587388;533.4612041837772;534.7486681259802;556.168528050567;563.1637019026742;567.9716014199273;7198;7687.89157077605;7775.650095745705;7877.094134174643;8150.4294699370475;509.5465036117858;519.5142541723501;534.2707204665682;535.1357557544537;542.4385760737617;3383.1880348716622;3684.3552378333684;3871.825767840454;3898.9805050975133;3904.5509766376663;47792.5220747795;48518;48849.51150488521;57860;58757;45679;46377;46408.5359146411;46729;46940.53059469361;46850;47075;48051.27923081157;48392.27411588759;48811.75594122078;7614.543127412373;7817.140114587504;7937.841243174988;7993.360531157609;8041.325699669377;35585.46621800623;36437.27125457529;36617.633823661425;37238.6276137246;37505.62494375021;47723.52276477191;48184.518154818004;48410.5158948406;48476.7576162117;48647.75676121597;10937.945310273397;10947.124230061416;11085.113190944867;11252.437378130897;11324.037456815933;11485.253458525169;11641.359725215194;11672.124590655565;12009.339486328336;12223.205491643015;10441.582336706446;10523.631672891719;10718.624848130277;11059.889401106208;11211.327320360804;10873.293235939638;10976.286541374786;11209.775804484028;11312.86871312862;11451.828222576502;7045;9488.525573721425;10502.159827213958;10580.947095264475;10715.535426851711;9031.187193152648;9382;9439.764005899633;9663.226941844496;9881.752956176153;8657.22085012352;8783.472991620523;9068.818623627358;9264.768380790534;9266.351355405057 04:07:07 INFO - PROCESS | 5028 | __end_tp_report 04:07:07 INFO - PROCESS | 5028 | __start_cc_report 04:07:07 INFO - PROCESS | 5028 | _x_x_mozilla_cycle_collect,942 04:07:07 INFO - PROCESS | 5028 | __end_cc_report 04:07:07 INFO - PROCESS | 5028 | __startTimestamp1451390827871__endTimestamp 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | ------- Summary: start ------- 04:07:07 INFO - PROCESS | 5028 | Number of tests: 6 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#0] dojo.html Cycles:165 Average:5483.10 Median:5673.29 stddev:620.99 (10.9%) stddev-sans-first:596.48 04:07:07 INFO - PROCESS | 5028 | Values: 3198.8 3251.9 3298.4 3307.5 3316.9 5307.7 5387.3 5447.9 5450.8 5460.8 5426.2 5536.4 5579.6 5604.3 5606.0 4941.2 4974.4 4989.8 5016.1 5037.7 4840.4 4990.2 5005.1 5046.5 5064.6 4900.0 4967.4 4998.8 5007.9 5016.7 4951.9 4952.8 4955.3 4958.9 4986.0 4921.8 4934.3 4934.5 4935.9 5022.1 5355.8 5379.8 5401.9 5421.8 5460.5 5904.9 5916.2 5920.6 5928.8 5936.6 5883.6 5956.0 5972.3 5983.5 6005.7 5452.5 5484.5 5488.4 5531.9 5581.6 6070.5 6085.2 6088.0 6134.4 6151.1 5674.3 5715.1 5956.6 5958.6 5970.4 5902.0 5924.8 5996.2 5998.8 6043.0 5876.2 5914.6 5917.4 5917.4 5921.9 5879.2 5919.8 5928.9 5929.7 5993.8 4495.2 4506.7 4578.6 4578.9 4589.5 4034.8 4059.5 4061.1 4085.7 4093.5 5516.3 5575.7 5587.0 5589.9 5630.7 5855.8 5900.4 5918.4 5967.1 5971.6 5519.4 5523.0 5525.0 5526.4 5529.9 5085.5 5090.9 5095.7 5096.1 5140.7 5935.3 6040.9 6048.7 6057.9 6097.6 5991.2 5992.9 5996.9 6004.0 6021.0 6062.4 6120.2 6123.6 6133.7 6137.5 5809.7 5850.3 5897.6 5927.2 5931.0 5835.5 5844.6 5864.7 5887.5 5888.5 5678.9 5680.9 5688.9 5692.1 5733.5 5623.4 5629.6 5661.6 5683.1 5847.7 5639.0 5661.6 5668.3 5673.3 5707.5 5799.3 5845.4 5855.3 5858.4 5906.6 5633.5 5728.2 5739.4 5740.5 5741.6 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#1] ext.html Cycles:180 Average:45606.93 Median:34258.49 stddev:78912.86 (230.3%) stddev-sans-first:79061.62 04:07:07 INFO - PROCESS | 5028 | Values: 518.9 525.2 527.4 550.8 581.2 27254.9 27857.6 35667.6 35800.8 35962.3 38444.4 38890.0 38913.4 38956.2 38991.8 7333.2 8296.3 8518.9 8574.2 8610.6 7565.4 7698.1 7701.1 9934.4 10132.1 9884.0 9974.6 9976.3 9980.3 9984.4 9781.8 9842.3 9879.9 9983.9 9998.6 7384.9 7572.4 9803.4 10045.5 10058.3 35883.3 36211.5 36220.5 36228.6 36304.6 2720.6 2736.4 2742.1 2838.3 3146.6 27863.9 28235.3 29118.4 29207.3 29539.3 3497.4 3506.2 3512.9 3620.8 3661.8 266031.0 266259.0 266334.0 266520.0 266750.7 47398.3 48309.1 53098.5 53102.0 53445.5 58062.4 58961.4 59145.0 59174.4 59200.4 14520.7 14838.0 14845.1 14845.6 14852.8 10751.8 10776.2 10777.8 10809.4 10813.0 17715.0 17772.6 17821.7 18214.9 18336.2 6946.4 7233.0 7236.5 7256.1 7296.2 907.7 945.9 1027.9 1067.9 1073.4 27484.9 28536.6 28971.4 29502.0 30159.7 1012.6 1016.7 1031.5 1038.4 1131.5 12754.6 13252.7 13320.9 13362.9 15048.5 314678.0 316930.0 318251.0 318436.0 318683.0 51197.2 51231.7 51259.7 51316.0 51328.0 1348.6 1352.6 1369.6 1375.3 1375.8 27510.9 28439.3 28732.4 28748.7 28944.9 44333.0 44684.8 44728.6 44750.3 44781.6 238390.0 273363.0 280146.0 379671.0 382875.0 28317.6 28332.3 28433.0 28442.9 28703.0 39081.4 39854.0 40772.8 40831.6 41006.8 34085.7 34103.3 34329.0 34525.0 34931.0 34526.8 34602.5 34687.7 34927.8 35051.3 32921.7 33857.2 34211.3 34305.7 34737.0 30053.4 31297.8 31702.8 31767.0 31811.7 23747.3 23785.8 23982.3 24178.9 24258.0 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#2] jquery.html Cycles:180 Average:27650.77 Median:441.04 stddev:86630.13 (19642.3%) stddev-sans-first:86848.91 04:07:07 INFO - PROCESS | 5028 | Values: 353.8 357.7 357.8 361.6 362.8 14097.2 14497.8 15356.4 15629.9 16293.7 14782.7 16103.8 16194.0 16195.2 16541.8 5144.1 5268.7 5281.2 5283.8 5286.3 3991.0 4115.8 5181.1 5226.8 5708.1 5719.5 5759.5 5762.0 5763.5 5764.2 5621.6 5743.3 5754.4 5754.5 5777.2 5026.3 5029.1 5059.8 5060.8 5066.7 17567.0 18226.3 18881.9 20916.3 21063.8 2012.6 2133.7 2292.1 2383.3 2383.9 9137.9 9244.2 9436.3 11211.9 12290.8 1858.5 1902.8 1932.9 1975.6 1995.7 57350.4 57980.1 62146.0 64872.0 64898.7 9518.0 9826.6 10015.0 10030.6 10120.3 13056.5 13071.4 13077.3 13082.4 13090.0 6839.0 7258.3 7498.8 7550.3 7562.7 7374.9 7378.4 7378.6 7430.6 7437.0 4203.7 4247.8 4266.4 4277.3 4278.1 1639.9 1661.0 1669.8 1716.2 1782.9 439.3 444.4 852.9 945.9 1005.9 10458.9 10748.9 10945.9 11052.3 11178.6 407.8 431.3 442.7 442.9 450.0 5478.6 5644.2 5690.1 5745.6 5772.7 518439.0 519173.0 530394.0 532129.0 544045.0 80072.2 81884.2 82261.6 82422.0 82853.6 481.0 481.8 481.9 482.4 482.9 9800.6 9866.7 9924.4 10039.7 10075.9 32360.2 32478.4 33060.7 33075.3 34444.0 39013.4 45226.0 45774.0 48371.8 50222.0 9132.3 9418.7 9431.3 9461.4 9467.3 10660.5 10890.7 10916.5 10977.6 11001.6 9634.4 9682.0 9905.2 9936.0 9971.8 9967.3 10044.5 10047.4 10221.2 10486.8 8601.9 8907.7 10466.5 10574.6 10619.2 14582.7 14711.3 14728.9 15126.7 15257.9 15603.9 15718.1 15812.6 15816.6 15890.7 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#3] mootools.html Cycles:180 Average:5344.41 Median:6303.17 stddev:2755.47 (43.7%) stddev-sans-first:2746.71 04:07:07 INFO - PROCESS | 5028 | Values: 1334.1 1363.5 1365.5 1484.4 1752.7 6879.3 7481.8 7627.4 7631.7 7632.2 7423.2 7580.3 7619.4 7621.8 7637.0 2028.6 2071.5 2076.5 2226.2 2271.0 2274.6 2306.2 2323.9 2324.3 2324.6 2279.0 2282.3 2353.1 2354.0 2354.3 2262.7 2266.9 2283.3 2346.1 2346.1 2280.3 2294.1 2345.9 2346.8 2349.9 7600.1 7685.8 7692.0 7785.2 7795.8 4730.1 4843.1 4844.0 4845.5 4853.9 2870.1 2919.6 2920.7 2962.6 3116.2 863.2 878.3 892.7 894.0 1735.3 10059.8 10135.6 10184.3 10198.3 10200.9 4240.0 4350.4 4368.1 4374.4 4467.0 8930.8 9048.3 9050.4 9077.3 9080.6 4735.1 4739.0 4759.5 4777.6 4784.4 4312.3 4329.7 4331.8 4333.3 4362.7 3537.6 3596.6 3617.4 3764.7 3836.4 1231.4 1248.7 1259.2 1261.2 1264.3 1002.7 1003.5 1041.4 1073.8 1238.5 6802.3 6840.5 6844.0 6848.6 6859.3 613.4 621.9 624.6 628.5 759.7 5467.3 5585.2 5590.1 5601.0 5607.2 8889.1 8992.8 9030.1 9051.2 9149.5 9144.5 9302.6 9325.3 9347.7 9349.6 7006.9 7034.9 7178.1 7186.3 7188.1 7100.5 7131.7 7155.1 7159.4 7167.6 8142.7 8371.2 8455.6 8589.5 8589.5 8557.4 8604.7 8736.7 8747.5 8748.3 6666.7 6744.3 6768.1 6779.8 6786.4 6647.6 6789.2 7096.8 7273.0 7280.9 6706.6 6713.6 6810.5 6872.6 6916.9 6609.4 6656.4 6686.2 6700.5 6869.8 6565.4 6772.6 6778.6 6797.8 6799.9 6227.0 6245.4 6246.5 6299.0 6332.0 6257.8 6296.7 6307.3 6309.9 6311.1 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#4] prototype.html Cycles:180 Average:5303.47 Median:5996.36 stddev:1591.45 (26.5%) stddev-sans-first:1551.54 04:07:07 INFO - PROCESS | 5028 | Values: 331.5 336.1 338.3 344.4 345.8 5843.4 5991.6 6005.6 6020.8 6091.5 5780.0 5953.0 5964.9 5971.6 6001.1 4630.1 4634.6 4635.1 4640.1 4644.0 4391.7 4476.4 4494.3 4602.4 4624.5 4549.6 4580.1 4589.2 4589.9 4617.7 4583.2 4590.6 4597.1 4597.3 4603.6 4031.1 4035.9 4043.4 4054.9 4056.6 5575.8 5623.9 5645.0 5668.3 5719.9 5332.1 5335.7 5341.2 5342.6 5364.4 6128.1 6358.6 6361.8 6362.3 6364.4 4313.2 4367.6 4409.6 4431.7 4437.5 6547.8 6603.7 6633.8 6642.8 6646.3 4494.8 4502.8 4509.3 4509.8 4511.5 4456.2 4542.6 4554.7 4556.6 4569.0 5224.7 5227.6 5231.8 5238.0 5253.9 6360.9 6376.4 6378.9 6381.2 6383.2 1594.9 1611.3 1621.3 1625.0 1625.8 1066.8 1074.8 1096.6 1098.6 1112.1 6039.8 6051.4 6062.8 6067.5 6073.5 6538.2 6542.9 6544.0 6546.9 6565.8 5822.0 5922.2 5926.8 5927.0 5937.9 3536.5 3564.6 3565.6 3567.9 3568.9 6596.6 6606.9 6607.6 6617.1 6622.4 6567.2 6602.0 6602.6 6617.3 6705.9 6571.6 6693.6 6731.4 6750.0 6752.7 6278.9 6446.3 6570.3 6577.1 6577.7 6335.6 6434.6 6495.5 6514.9 6536.6 6772.4 6814.5 6815.3 6821.0 6823.6 4383.9 4421.6 4466.6 4469.6 4469.8 6614.9 6629.1 6630.1 6641.6 6642.3 6348.9 6431.2 6436.0 6440.2 6443.4 6308.7 6351.1 6351.3 6412.0 6419.1 6243.7 6264.3 6287.6 6293.6 6296.5 6441.4 6446.8 6448.9 6455.5 6465.1 6137.4 6234.4 6286.4 6302.1 6315.7 04:07:07 INFO - PROCESS | 5028 | 04:07:07 INFO - PROCESS | 5028 | [#5] yui.html Cycles:180 Average:13260.44 Median:48555.50 stddev:15771.51 (32.5%) stddev-sans-first:15787.12 04:07:07 INFO - PROCESS | 5028 | Values: 604.5 618.2 663.0 678.3 695.7 12152.7 12400.1 12448.4 12475.8 12499.3 11087.1 11163.3 11218.8 11254.5 13920.7 805.9 817.0 819.4 820.4 820.5 643.3 678.3 761.6 813.0 814.4 830.2 837.1 840.4 849.5 858.0 657.2 838.5 839.7 840.2 840.2 508.8 579.4 619.6 626.6 630.6 11486.4 11597.7 11673.7 11676.9 11711.3 10992.2 11248.2 11337.8 11531.5 11799.6 8460.4 8789.1 9015.8 9100.4 9339.3 3405.8 3423.3 3479.1 3480.5 3485.3 48247.0 48387.5 48477.0 48593.0 49208.0 9109.8 9234.7 9240.2 9270.4 9396.8 16383.2 16615.8 16636.3 16645.0 16648.3 6377.9 6495.5 6535.8 6550.5 6614.2 4061.3 4064.2 4083.0 4090.0 4155.9 2725.9 2755.1 2756.9 2764.6 2792.8 547.9 550.4 558.4 560.9 561.8 533.5 534.7 556.2 563.2 568.0 7198.0 7687.9 7775.7 7877.1 8150.4 509.5 519.5 534.3 535.1 542.4 3383.2 3684.4 3871.8 3899.0 3904.6 47792.5 48518.0 48849.5 57860.0 58757.0 45679.0 46377.0 46408.5 46729.0 46940.5 46850.0 47075.0 48051.3 48392.3 48811.8 7614.5 7817.1 7937.8 7993.4 8041.3 35585.5 36437.3 36617.6 37238.6 37505.6 47723.5 48184.5 48410.5 48476.8 48647.8 10937.9 10947.1 11085.1 11252.4 11324.0 11485.3 11641.4 11672.1 12009.3 12223.2 10441.6 10523.6 10718.6 11059.9 11211.3 10873.3 10976.3 11209.8 11312.9 11451.8 7045.0 9488.5 10502.2 10580.9 10715.5 9031.2 9382.0 9439.8 9663.2 9881.8 8657.2 8783.5 9068.8 9264.8 9266.4 04:07:07 INFO - PROCESS | 5028 | -------- Summary: end -------- 04:07:07 INFO - PROCESS | 5028 | 04:07:08 INFO - TEST-INFO | 5028: exit 0 04:07:08 INFO - TEST-OK | dromaeo_css | took 1116635ms 04:07:08 INFO - TEST-START | kraken 04:07:08 INFO - operating with platform_type : linux_ 04:07:08 INFO - Initialising browser for kraken test... 04:07:08 INFO - TEST-INFO | started process 5221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2Ws3c/profile http://localhost:52774/getInfo.html) 04:07:13 INFO - PROCESS | 5221 | __metrics Screen width/height:1600/1200 04:07:13 INFO - PROCESS | 5221 | colorDepth:24 04:07:13 INFO - PROCESS | 5221 | Browser inner width/height: 1024/697 04:07:13 INFO - PROCESS | 5221 | __metrics 04:07:13 INFO - PROCESS | 5221 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:07:13 INFO - PROCESS | 5221 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:15 INFO - TEST-INFO | 5221: exit 0 04:07:15 INFO - Browser initialized. 04:07:15 INFO - Running cycle 1/1 for kraken test... 04:07:15 INFO - TEST-INFO | started process 5306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ2Ws3c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:26 INFO - PROCESS | 5306 | RSS: Main: 148566016 04:07:26 INFO - PROCESS | 5306 | 04:07:29 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52774/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:29 INFO - PROCESS | 5306 | RSS: Main: 185233408 04:07:29 INFO - PROCESS | 5306 | 04:07:32 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52774/tests/kraken/driver.html?testName=audio-dft) 04:07:33 INFO - PROCESS | 5306 | RSS: Main: 175734784 04:07:33 INFO - PROCESS | 5306 | 04:07:36 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52774/tests/kraken/driver.html?testName=audio-fft) 04:07:36 INFO - PROCESS | 5306 | RSS: Main: 160018432 04:07:36 INFO - PROCESS | 5306 | 04:07:38 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52774/tests/kraken/driver.html?testName=audio-oscillator) 04:07:39 INFO - PROCESS | 5306 | RSS: Main: 161288192 04:07:39 INFO - PROCESS | 5306 | 04:07:41 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:41 INFO - PROCESS | 5306 | RSS: Main: 162811904 04:07:41 INFO - PROCESS | 5306 | 04:07:44 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52774/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:45 INFO - PROCESS | 5306 | RSS: Main: 164413440 04:07:45 INFO - PROCESS | 5306 | 04:07:48 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52774/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:49 INFO - PROCESS | 5306 | RSS: Main: 166305792 04:07:49 INFO - PROCESS | 5306 | 04:07:52 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52774/tests/kraken/driver.html?testName=json-parse-financial) 04:07:52 INFO - PROCESS | 5306 | RSS: Main: 164933632 04:07:52 INFO - PROCESS | 5306 | 04:07:54 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:54 INFO - PROCESS | 5306 | RSS: Main: 177897472 04:07:54 INFO - PROCESS | 5306 | 04:07:56 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:57 INFO - PROCESS | 5306 | RSS: Main: 177319936 04:07:57 INFO - PROCESS | 5306 | 04:07:59 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:59 INFO - PROCESS | 5306 | RSS: Main: 182566912 04:07:59 INFO - PROCESS | 5306 | 04:08:02 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:02 INFO - PROCESS | 5306 | RSS: Main: 189554688 04:08:02 INFO - PROCESS | 5306 | 04:08:05 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:06 INFO - PROCESS | 5306 | RSS: Main: 184528896 04:08:06 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | Cycle 1(1): loaded http://localhost:52774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52774/tests/kraken/driver.html?testName=ai-astar) 04:08:07 INFO - PROCESS | 5306 | RSS: Main: 244129792 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | __start_tp_report 04:08:07 INFO - PROCESS | 5306 | _x_x_mozilla_page_load 04:08:07 INFO - PROCESS | 5306 | _x_x_mozilla_page_load_details 04:08:07 INFO - PROCESS | 5306 | |i|pagename|runs| 04:08:07 INFO - PROCESS | 5306 | |0;ai-astar;107;110;105;109;109;109;97;108;108;102 04:08:07 INFO - PROCESS | 5306 | |1;audio-beat-detection;152;125;150;166;130;145;151;127;170;125 04:08:07 INFO - PROCESS | 5306 | |2;audio-dft;161;162;160;160;164;162;161;161;160;161 04:08:07 INFO - PROCESS | 5306 | |3;audio-fft;72;72;84;94;72;73;71;105;91;71 04:08:07 INFO - PROCESS | 5306 | |4;audio-oscillator;97;95;140;96;96;96;141;96;97;137 04:08:07 INFO - PROCESS | 5306 | |5;imaging-gaussian-blur;109;108;110;109;109;109;109;109;109;109 04:08:07 INFO - PROCESS | 5306 | |6;imaging-darkroom;146;145;145;145;146;146;145;145;145;145 04:08:07 INFO - PROCESS | 5306 | |7;imaging-desaturate;96;96;96;96;95;96;96;95;96;96 04:08:07 INFO - PROCESS | 5306 | |8;json-parse-financial;59;57;57;56;57;57;57;65;54;57 04:08:07 INFO - PROCESS | 5306 | |9;json-stringify-tinderbox;68;68;68;67;68;68;69;69;68;68 04:08:07 INFO - PROCESS | 5306 | |10;stanford-crypto-aes;86;86;86;86;87;86;87;87;85;95 04:08:07 INFO - PROCESS | 5306 | |11;stanford-crypto-ccm;121;129;119;116;113;120;113;115;117;118 04:08:07 INFO - PROCESS | 5306 | |12;stanford-crypto-pbkdf2;143;154;150;147;155;144;165;149;151;145 04:08:07 INFO - PROCESS | 5306 | |13;stanford-crypto-sha256-iterative;70;68;69;69;68;71;69;70;69;68 04:08:07 INFO - PROCESS | 5306 | __end_tp_report 04:08:07 INFO - PROCESS | 5306 | __start_cc_report 04:08:07 INFO - PROCESS | 5306 | _x_x_mozilla_cycle_collect,903 04:08:07 INFO - PROCESS | 5306 | __end_cc_report 04:08:07 INFO - PROCESS | 5306 | __startTimestamp1451390887957__endTimestamp 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | ------- Summary: start ------- 04:08:07 INFO - PROCESS | 5306 | Number of tests: 14 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#0] ai-astar Cycles:10 Average:106.40 Median:109.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 04:08:07 INFO - PROCESS | 5306 | Values: 107.0 110.0 105.0 109.0 109.0 109.0 97.0 108.0 108.0 102.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.50 stddev:16.72 (11.1%) stddev-sans-first:17.49 04:08:07 INFO - PROCESS | 5306 | Values: 152.0 125.0 150.0 166.0 130.0 145.0 151.0 127.0 170.0 125.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 04:08:07 INFO - PROCESS | 5306 | Values: 161.0 162.0 160.0 160.0 164.0 162.0 161.0 161.0 160.0 161.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#3] audio-fft Cycles:10 Average:80.50 Median:72.50 stddev:12.29 (16.9%) stddev-sans-first:12.64 04:08:07 INFO - PROCESS | 5306 | Values: 72.0 72.0 84.0 94.0 72.0 73.0 71.0 105.0 91.0 71.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:96.00 stddev:20.89 (21.8%) stddev-sans-first:21.70 04:08:07 INFO - PROCESS | 5306 | Values: 97.0 95.0 140.0 96.0 96.0 96.0 141.0 96.0 97.0 137.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:08:07 INFO - PROCESS | 5306 | Values: 109.0 108.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:08:07 INFO - PROCESS | 5306 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:08:07 INFO - PROCESS | 5306 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:2.88 (5.0%) stddev-sans-first:3.00 04:08:07 INFO - PROCESS | 5306 | Values: 59.0 57.0 57.0 56.0 57.0 57.0 57.0 65.0 54.0 57.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 04:08:07 INFO - PROCESS | 5306 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 68.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.85 (3.3%) stddev-sans-first:2.99 04:08:07 INFO - PROCESS | 5306 | Values: 86.0 86.0 86.0 86.0 87.0 86.0 87.0 87.0 85.0 95.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:118.50 stddev:4.70 (4.0%) stddev-sans-first:4.87 04:08:07 INFO - PROCESS | 5306 | Values: 121.0 129.0 119.0 116.0 113.0 120.0 113.0 115.0 117.0 118.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:150.50 stddev:6.55 (4.4%) stddev-sans-first:6.39 04:08:07 INFO - PROCESS | 5306 | Values: 143.0 154.0 150.0 147.0 155.0 144.0 165.0 149.0 151.0 145.0 04:08:07 INFO - PROCESS | 5306 | 04:08:07 INFO - PROCESS | 5306 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.99 (1.4%) stddev-sans-first:1.00 04:08:07 INFO - PROCESS | 5306 | Values: 70.0 68.0 69.0 69.0 68.0 71.0 69.0 70.0 69.0 68.0 04:08:07 INFO - PROCESS | 5306 | -------- Summary: end -------- 04:08:07 INFO - PROCESS | 5306 | 04:08:08 INFO - TEST-INFO | 5306: exit 0 04:08:08 INFO - TEST-OK | kraken | took 60318ms 04:08:08 INFO - TEST-START | v8_7 04:08:08 INFO - operating with platform_type : linux_ 04:08:08 INFO - Initialising browser for v8_7 test... 04:08:09 INFO - TEST-INFO | started process 5561 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5t_9uy/profile http://localhost:52774/getInfo.html) 04:08:14 INFO - PROCESS | 5561 | __metrics Screen width/height:1600/1200 04:08:14 INFO - PROCESS | 5561 | colorDepth:24 04:08:14 INFO - PROCESS | 5561 | Browser inner width/height: 1024/697 04:08:14 INFO - PROCESS | 5561 | __metrics 04:08:14 INFO - PROCESS | 5561 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:08:14 INFO - PROCESS | 5561 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:15 INFO - TEST-INFO | 5561: exit 0 04:08:15 INFO - Browser initialized. 04:08:15 INFO - Running cycle 1/1 for v8_7 test... 04:08:15 INFO - TEST-INFO | started process 5644 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5t_9uy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:27 INFO - PROCESS | 5644 | RSS: Main: 148619264 04:08:27 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | Cycle 1(1): loaded http://localhost:52774/tests/v8_7/run.html (next: http://localhost:52774/tests/v8_7/run.html) 04:08:49 INFO - PROCESS | 5644 | RSS: Main: 618291200 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | __start_tp_report 04:08:49 INFO - PROCESS | 5644 | _x_x_mozilla_page_load 04:08:49 INFO - PROCESS | 5644 | _x_x_mozilla_page_load_details 04:08:49 INFO - PROCESS | 5644 | |i|pagename|runs| 04:08:49 INFO - PROCESS | 5644 | |0;Richards;167.50418760469012 04:08:49 INFO - PROCESS | 5644 | |1;DeltaBlue;190.98548510313216 04:08:49 INFO - PROCESS | 5644 | |2;Encrypt;279.79854504756577 04:08:49 INFO - PROCESS | 5644 | |3;Decrypt;5256.544502617801 04:08:49 INFO - PROCESS | 5644 | |4;RayTrace;2036.6598778004072 04:08:49 INFO - PROCESS | 5644 | |5;Earley;804.5052292839904 04:08:49 INFO - PROCESS | 5644 | |6;Boyer;12204.819277108434 04:08:49 INFO - PROCESS | 5644 | |7;RegExp;25725 04:08:49 INFO - PROCESS | 5644 | |8;Splay;584.7953216374269 04:08:49 INFO - PROCESS | 5644 | |9;NavierStokes;4822.115384615385 04:08:49 INFO - PROCESS | 5644 | __end_tp_report 04:08:49 INFO - PROCESS | 5644 | __startTimestamp1451390929510__endTimestamp 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | ------- Summary: start ------- 04:08:49 INFO - PROCESS | 5644 | Number of tests: 10 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 167.5 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#1] DeltaBlue Cycles:1 Average:190.99 Median:190.99 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 191.0 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 279.8 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 5256.5 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#4] RayTrace Cycles:1 Average:2036.66 Median:2036.66 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 2036.7 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#5] Earley Cycles:1 Average:804.51 Median:804.51 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 804.5 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 12204.8 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#7] RegExp Cycles:1 Average:25725.00 Median:25725.00 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 25725.0 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#8] Splay Cycles:1 Average:584.80 Median:584.80 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 584.8 04:08:49 INFO - PROCESS | 5644 | 04:08:49 INFO - PROCESS | 5644 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:08:49 INFO - PROCESS | 5644 | Values: 4822.1 04:08:49 INFO - PROCESS | 5644 | -------- Summary: end -------- 04:08:49 INFO - PROCESS | 5644 | 04:08:50 INFO - TEST-INFO | 5644: exit 0 04:08:50 INFO - TEST-OK | v8_7 | took 41341ms 04:08:50 INFO - SUITE-END | took 1218s 04:08:50 INFO - Completed test suite (00:20:18) 04:08:50 INFO - Working with test: dromaeo_css 04:08:50 INFO - Generating results file: dromaeo_css 04:08:50 INFO - Working with test: kraken 04:08:50 INFO - Generating results file: kraken 04:08:50 INFO - javascript benchmark 04:08:50 INFO - Working with test: v8_7 04:08:50 INFO - Generating results file: v8_7 04:08:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:08:50 INFO - process_Request line: dromaeo_css 6730.22 graph.html#tests=[[72,63,35]] 04:08:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:50 INFO - process_Request line: kraken 1501.70 graph.html#tests=[[232,63,35]] 04:08:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:50 INFO - process_Request line: v8_7 19768.37 graph.html#tests=[[230,63,35]] 04:08:50 INFO - RETURN: dromaeo_css: 6730.22 04:08:50 INFO - RETURN: kraken: 1501.70 04:08:50 INFO - RETURN: v8_7: 19768.37 04:08:50 INFO - javascript benchmark 04:08:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3198.7600929930254, 3251.9349613007757, 3298.356820420019, 3307.503874418838, 3316.8839090631827, 5307.708076055816, 5387.272718183044, 5447.945520544793, 5450.836474905749, 5460.754266058022, 5426.21319908613, 5536.446355364462, 5579.553635709143, 5604.299462567179, 5606.046972014757, 4941.234108713137, 4974.403071631409, 4989.75051247438, 5016.097102521545, 5037.672551284155, 4840.419149702041, 4990.226514890198, 5005.124103281929, 5046.495350464943, 5064.56951159152, 4900.0, 4967.428745694219, 4998.800047998076, 5007.874803129915, 5016.673916195436, 4951.925721114186, 4952.752362381866, 4955.281484184773, 4958.87602809929, 4985.975070124662, 4921.827736029221, 4934.309196712463, 4934.5312195341385, 4935.851924442272, 5022.096022715909, 5355.758990845421, 5379.784808607651, 5401.891962160735, 5421.783128674848, 5460.481254280837, 5904.852378690524, 5916.201312822757, 5920.615160014629, 5928.7924922627935, 5936.5547583931375, 5883.6469811811, 5956.0, 5972.283326000907, 5983.491403230731, 6005.669688167149, 5452.482014208644, 5484.478974497416, 5488.423715509894, 5531.889362212773, 5581.553475721973, 6070.544709146831, 6085.174537170622, 6087.995480745627, 6134.386561343919, 6151.108089327023, 5674.347450043216, 5715.057015592464, 5956.5532585055425, 5958.582899197101, 5970.432808883149, 5902.026165682614, 5924.822255332347, 5996.190514280604, 5998.790042348497, 6043.0, 5876.206712093898, 5914.615549989323, 5917.378675239038, 5917.408259174048, 5921.881562368729, 5879.206307148565, 5919.792807251725, 5928.851778705481, 5929.673867937218, 5993.820185394445, 4495.21333766596, 4506.7070640408265, 4578.5650363215445, 4578.88552786183, 4589.472210695746, 4034.798260086984, 4059.4925634295714, 4061.0659548304056, 4085.6935729820384, 4093.5087789465456, 5516.3380394352935, 5575.721213939287, 5586.994341018656, 5589.944100559023, 5630.746616402272, 5855.795047173328, 5900.350961394243, 5918.3693820364915, 5967.104934259809, 5971.552133589998, 5519.39286678465, 5522.972385138129, 5525.033119204123, 5526.4197259288, 5529.861753456195, 5085.516875896784, 5090.9236361454605, 5095.719735414514, 5096.082705113041, 5140.717260550631, 5935.2877654681715, 6040.939590604125, 6048.727807248684, 6057.909131363033, 6097.639735507201, 5991.191189189403, 5992.940070599413, 5996.850078748066, 6004.039353703386, 6020.969895150496, 6062.393760623902, 6120.17377654011, 6123.632582045091, 6133.693315334126, 6137.508999280136, 5809.680467574324, 5850.297964244318, 5897.616654917417, 5927.229460170151, 5931.021381472009, 5835.4748072673665, 5844.649321040752, 5864.706764661664, 5887.470127688357, 5888.499477544457, 5678.914816277842, 5680.914786278292, 5688.886222275614, 5692.0608099663095, 5733.483986441241, 5623.409541998195, 5629.605927585029, 5661.603687741818, 5683.119116536944, 5847.678377689268, 5639.0, 5661.575381846295, 5668.26312579362, 5673.290838645169, 5707.543396528351, 5799.3040835100055, 5845.357010728731, 5855.268091488564, 5858.443447872445, 5906.645601263938, 5633.549316054788, 5728.2266893970445, 5739.368669446441, 5740.512056475246, 5741.569382296261], "unit": "score", "name": "dojo.html", "value": 5442.016723503539}, {"lowerIsBetter": false, "replicates": [518.949128015768, 525.2252926932772, 527.3961314295132, 550.790699534177, 581.2153592649926, 27254.863725681367, 27857.58213626797, 35667.64332356676, 35800.82099589498, 35962.28075438496, 38444.42333365002, 38890.0, 38913.416298755474, 38956.22087558247, 38991.80504097475, 7333.156686980986, 8296.336293096552, 8518.935133108362, 8574.185452382013, 8610.612522436473, 7565.432592555553, 7698.076230852305, 7701.114371847225, 9934.403935763878, 10132.138768204675, 9884.01159884013, 9974.601015959353, 9976.251781116409, 9980.30137890348, 9984.351017183895, 9781.755456113655, 9842.26183036268, 9879.901200988006, 9983.850242246299, 9998.600055997751, 7384.889226661604, 7572.39420846331, 9803.411795292306, 10045.497725113788, 10058.295919285652, 35883.28233435316, 36211.4568281476, 36220.45669314962, 36228.63771362305, 36304.63695363065, 2720.578310361897, 2736.3979924416594, 2742.081402730088, 2838.262051866509, 3146.5909431773953, 27863.860680696467, 28235.29411764702, 29118.417631647248, 29207.269818254714, 29539.261518461997, 3497.3879571075213, 3506.2286297014616, 3512.947305790415, 3620.7827530348263, 3661.7986010769396, 266031.0, 266259.0, 266334.0, 266520.0, 266750.6662466695, 47398.28902566464, 48309.067637294116, 53098.469015309354, 53102.0, 53445.46554534483, 58062.419375806545, 58961.41038589645, 59145.0, 59174.40825591775, 59200.40799592035, 14520.709585808436, 14838.0, 14845.109293442429, 14845.554633361016, 14852.777208341884, 10751.78496430067, 10776.19178561611, 10777.78444431107, 10809.35143891369, 10813.0, 17715.0, 17772.644547108986, 17821.7326740099, 18214.90892545529, 18336.174872130785, 6946.409555187764, 7233.0, 7236.529625574321, 7256.12926448819, 7296.16094149169, 907.7276816954887, 945.8959514453404, 1027.9074883260541, 1067.9038886500252, 1073.4042606353394, 27484.862575686995, 28536.571951420745, 28971.42057158845, 29502.0, 30159.729718923605, 1012.6303899076784, 1016.7305663999047, 1031.5203430404897, 1038.413296487482, 1131.530414877833, 12754.61736147917, 13252.73494530104, 13320.93339533296, 13362.933185334012, 15048.473303434328, 314678.0, 316930.0, 318251.0, 318436.0, 318683.0, 51197.232041519404, 51231.74384128056, 51259.74370128125, 51316.0, 51328.0, 1348.5766685272322, 1352.6145048661085, 1369.6096612465399, 1375.3329635127157, 1375.8417781955204, 27510.862445687642, 28439.28901777472, 28732.42535149327, 28748.712512874605, 28944.855275723487, 44333.0, 44684.776576116914, 44728.55271447374, 44750.3287450682, 44781.55218447774, 238390.0, 273363.0, 280146.0, 379671.0, 382875.0, 28317.575236371882, 28332.291692707848, 28433.0, 28442.857785710938, 28703.0, 39081.41377879391, 39854.0, 40772.79613601913, 40831.59168408278, 41006.79496602617, 34085.65914340825, 34103.31793364169, 34329.0, 34525.0, 34931.0, 34526.82736586301, 34602.48096278608, 34687.65312346945, 34927.82536087303, 35051.29897402089, 32921.67078329186, 33857.15357116092, 34211.31577368489, 34305.65694343125, 34737.0, 30053.398932021675, 31297.8435107823, 31702.841485793346, 31767.0, 31811.68188318087, 23747.287581372588, 23785.762142379048, 23982.28053158408, 24178.87910560436, 24258.0], "unit": "score", "name": "ext.html", "value": 17757.26643149885}, {"lowerIsBetter": false, "replicates": [353.80187095226677, 357.7174032514314, 357.8264541697277, 361.60223753870747, 362.791394947905, 14097.154170749736, 14497.782533262009, 15356.385744570218, 15629.921850390747, 16293.674126517462, 14782.704345913075, 16103.758443623356, 16194.0, 16195.190240487958, 16541.83458165421, 5144.0740666679885, 5268.657537260085, 5281.181416880389, 5283.788648454077, 5286.31277933868, 3990.9600903990877, 4115.835366585333, 5181.0674078665825, 5226.7909283628605, 5708.08670612702, 5719.485246327829, 5759.510441612468, 5762.02045652238, 5763.481286684198, 5764.164196191549, 5621.550275977912, 5743.339515955677, 5754.424557544254, 5754.539636829044, 5777.1623114648355, 5026.2711906773675, 5029.069622119883, 5059.772310246048, 5060.84817455477, 5066.69599824008, 17567.03381314027, 18226.27094916202, 18881.90559047196, 20916.267930622354, 21063.789362106338, 2012.5874195789827, 2133.7439507259073, 2292.1289909834322, 2383.2611890314056, 2383.8569685818907, 9137.862932056025, 9244.168024877794, 9436.292278079172, 11211.887881121247, 12290.815637765441, 1858.4610462965725, 1902.838258748008, 1932.9033548322527, 1975.6443840108918, 1995.7106219598222, 57350.426495735344, 57980.130298045144, 62146.0, 64872.0, 64898.67550662217, 9517.952410237904, 9826.557804898797, 10015.025025124576, 10030.598776049022, 10120.342177758423, 13056.543020994219, 13071.41178646963, 13077.346132693518, 13082.411291491906, 13090.0, 6839.0, 7258.346748792528, 7498.775036748906, 7550.282723141293, 7562.697492100255, 7374.889376659355, 7378.372838308804, 7378.557286562824, 7430.554166749904, 7436.96281518589, 4203.70574059819, 4247.830086796555, 4266.4240327556, 4277.272863613193, 4278.122984788173, 1639.9098049607387, 1660.966780664404, 1669.8246684097994, 1716.1590820498116, 1782.9375971840923, 439.34318194299726, 444.4311281559609, 852.9317654587618, 945.8817647794026, 1005.9094681478556, 10458.895411045793, 10748.946255268673, 10945.890541094646, 11052.336859788438, 11178.552857885594, 407.7594219410503, 431.2776100032433, 442.7343593843668, 442.9136318417878, 449.97525136117827, 5478.616496845262, 5644.153376993484, 5690.118031705092, 5745.569082318759, 5772.740226689809, 518439.0, 519173.0, 530394.0, 532129.0, 544045.0, 80072.19927800764, 81884.18115818885, 82261.58869205616, 82422.0, 82853.58573207216, 481.03072309296795, 481.7687509995222, 481.8795301174706, 482.35364611420863, 482.8816939849689, 9800.558974846292, 9866.654667086617, 9924.354916930377, 10039.69880903574, 10075.899241007495, 32360.190995225308, 32478.35043299168, 33060.66939330672, 33075.33849323048, 34444.0, 39013.41479877747, 45226.0, 45774.0, 48371.758141209066, 50222.0, 9132.315076369432, 9418.670346537838, 9431.292653050912, 9461.432314061178, 9467.289953253396, 10660.46697665129, 10890.727731806452, 10916.508757106109, 10977.560897564008, 11001.61494347694, 9634.373765705206, 9681.983391744046, 9905.207583393456, 9935.950320248352, 9971.800563988825, 9967.302288839712, 10044.54799534008, 10047.397156170653, 10221.23340749432, 10486.842697359698, 8601.870971935552, 8907.688230911886, 10466.476676166314, 10574.577016919236, 10619.203559732896, 14582.708345832812, 14711.33798979027, 14728.852711472748, 15126.697466050837, 15257.923710381378, 15603.921980390025, 15718.13550254747, 15812.60468488251, 15816.60458488501, 15890.68218635644], "unit": "score", "name": "jquery.html", "value": 7823.188498078062}, {"lowerIsBetter": false, "replicates": [1334.072819390524, 1363.5295822941089, 1365.460643045997, 1484.3839806480312, 1752.675754985327, 6879.312068793118, 7481.812954676129, 7627.3898088152955, 7631.656575454104, 7632.236776322365, 7423.22056184101, 7580.317771400573, 7619.42854285928, 7621.847563048749, 7637.045369328834, 2028.6449871272541, 2071.4510654676524, 2076.480879780055, 2226.2096955580737, 2271.0461606125386, 2274.590573696734, 2306.215886598556, 2323.907043718249, 2324.2794733632545, 2324.5583339165505, 2278.9544209115807, 2282.338121944634, 2353.0587764894008, 2354.0, 2354.3172479980785, 2262.7058482397347, 2266.9319920402413, 2283.3264187064774, 2346.1084787780705, 2346.120204923154, 2280.270313499681, 2294.128231272106, 2345.870977096259, 2346.835721499496, 2349.8707571083582, 7600.125985511681, 7685.807854803618, 7692.0, 7785.221477852226, 7795.844083118306, 4730.0776348612035, 4843.07981483517, 4843.975780121112, 4845.53967373099, 4853.927191092136, 2870.0959197852817, 2919.605853209811, 2920.73713365796, 2962.6000489934013, 3116.1586371679746, 863.1972265792873, 878.3456325037823, 892.683097500391, 893.9955300223522, 1735.3492440334874, 10059.849102263472, 10135.594576216943, 10184.28709990301, 10198.286119971604, 10200.94899525505, 4239.97880010598, 4350.390945267665, 4368.126374725068, 4374.431323927933, 4466.972596302803, 8930.776730581787, 9048.276137908952, 9050.366474346733, 9077.319201059814, 9080.636774529077, 4735.076660051326, 4739.0, 4759.547842954914, 4777.641676874248, 4784.378030856036, 4312.310030395121, 4329.675274354436, 4331.848385306562, 4333.349997500401, 4362.71642343253, 3537.6285490023693, 3596.604373518911, 3617.439296908983, 3764.661180493769, 3836.4245363195746, 1231.384307846077, 1248.6566194296458, 1259.1500737002486, 1261.1802328486558, 1264.342541878218, 1002.6741309074434, 1003.5283416794096, 1041.4324193314662, 1073.8174510333263, 1238.5417395563518, 6802.319768023158, 6840.521163518605, 6843.965780171067, 6848.623325717033, 6859.279775623588, 613.3896772711181, 621.9191505104308, 624.5815303746501, 628.5317438508249, 759.673340463606, 5467.343918729698, 5585.1901474286005, 5590.077637189818, 5600.971995139998, 5607.243022191952, 8889.066648001995, 8992.775180620536, 9030.096990301048, 9051.185393314634, 9149.542522873962, 9144.497052662035, 9302.627894884128, 9325.253979681609, 9347.719568412958, 9349.579268932914, 7006.894896576556, 7034.929650703428, 7178.102737157856, 7186.317299856505, 7188.137423509317, 7100.502964792415, 7131.679074441558, 7155.069840920647, 7159.427245820218, 7167.569945803269, 8142.715004974797, 8371.204735550113, 8455.577221139041, 8589.484630921916, 8589.484630922165, 8557.35819813504, 8604.655813767378, 8736.650533978569, 8747.475151490677, 8748.300135988979, 6666.699998499982, 6744.258131605421, 6768.052472653734, 6779.796606101825, 6786.355296246848, 6647.60114393138, 6789.219239787488, 7096.787096387116, 7273.0, 7280.854382912418, 6706.564073335413, 6713.6307503085845, 6810.489213309121, 6872.587644741331, 6916.896246556205, 6609.405153536205, 6656.36764507371, 6686.1642294713165, 6700.49746269022, 6869.793906182823, 6565.376289252514, 6772.5936443813525, 6778.627175505395, 6797.796066118024, 6799.89800153008, 6227.034809604518, 6245.375462453719, 6246.46905013079, 6299.0, 6332.018537126753, 6257.812265632038, 6296.748130074929, 6307.337729538516, 6309.873802524015, 6311.053341998737], "unit": "score", "name": "mootools.html", "value": 4361.106732956973}, {"lowerIsBetter": false, "replicates": [331.54081596988163, 336.099253999282, 338.2676505365883, 344.44544283703226, 345.7804294273136, 5843.444872737083, 5991.640501569909, 6005.579609427336, 6020.819375418733, 6091.45176934077, 5779.971100144493, 5952.970235148829, 5964.910526342108, 5971.611845230057, 6001.06983417571, 4630.050839577879, 4634.606058485025, 4635.072985402916, 4640.141573808839, 4644.047970166124, 4391.670624703144, 4476.440444944382, 4494.348319493672, 4602.355670206174, 4624.491305956342, 4549.61328287096, 4580.0610874770755, 4589.196890544158, 4589.885252868671, 4617.6536759742985, 4583.243764778807, 4590.632749380058, 4597.057603191338, 4597.2874204498185, 4603.562661547147, 4031.072853243741, 4035.899102522431, 4043.433919251307, 4054.878353649395, 4056.614621610972, 5575.776968921279, 5623.8594035149035, 5644.971775141098, 5668.348139963916, 5719.885602287973, 5332.093544097513, 5335.706536140511, 5341.2255222992835, 5342.599305052097, 5364.409914909357, 6128.111423843562, 6358.586691865014, 6361.8409539761415, 6362.331955144689, 6364.363563643645, 4313.1804957058375, 4367.58507941745, 4409.647228221735, 4431.667624928144, 4437.46750389952, 6547.803565892983, 6603.735850565971, 6633.834154146137, 6642.80071597848, 6646.302138275508, 4494.775261236925, 4502.819887204475, 4509.278515437514, 4509.751963642031, 4511.548845115528, 4456.22016147173, 4542.568455996675, 4554.681172317906, 4556.612687921497, 4569.040501494724, 5224.738763061831, 5227.581793456515, 5231.790728370898, 5237.973810130925, 5253.868653283622, 6360.936390636127, 6376.426121649074, 6378.872422551523, 6381.234251889803, 6383.234011918599, 1594.936202551908, 1611.2829790743242, 1621.2704283072665, 1625.0412256768564, 1625.8455446732542, 1066.7546464313252, 1074.7742973975396, 1096.6161843354762, 1098.6045023791428, 1112.1158678850334, 6039.849003774941, 6051.394860513913, 6062.818115456544, 6067.453929146398, 6073.544484163705, 6538.248101468392, 6542.869142617121, 6544.0, 6546.9345306547275, 6565.770198043046, 5821.970890145607, 5922.170896074553, 5926.822195334147, 5927.0, 5937.851553711105, 3536.5225694531423, 3564.590072141737, 3565.607783143852, 3567.928641427157, 3568.91077723059, 6596.637184954873, 6606.86786264272, 6607.603543787388, 6617.139771829631, 6622.37087476689, 6567.2447668518735, 6601.966990165019, 6602.570832895846, 6617.305182955816, 6705.865882682319, 6571.605703657796, 6693.631850248185, 6731.360520750619, 6749.966250168718, 6752.662366881538, 6278.874422511615, 6446.258680251831, 6570.310117437792, 6577.112089867998, 6577.704003319766, 6335.619862808247, 6434.64609446485, 6495.480361571157, 6514.902276465762, 6536.575122617015, 6772.424343930821, 6814.454843612598, 6815.318468153145, 6821.0, 6823.55646882951, 4383.868483945486, 4421.624161946271, 4466.553344665507, 4469.642428605769, 4469.798859051415, 6614.933850661624, 6629.07192992991, 6630.071789949315, 6641.601503909781, 6642.335766423513, 6348.936510634834, 6431.196100487439, 6435.967820160869, 6440.227172739301, 6443.420092191725, 6308.747650094128, 6351.1425957496995, 6351.301356850835, 6412.006139048455, 6419.133416988647, 6243.719032643451, 6264.2796078451565, 6287.559870809182, 6293.615404610979, 6296.5277604178955, 6441.420272175526, 6446.807340641996, 6448.9032664511005, 6455.515836312389, 6465.062565928009, 6137.35557766446, 6234.407731265523, 6286.371362863677, 6302.117703521419, 6315.652639104894], "unit": "score", "name": "prototype.html", "value": 4788.033483794281}, {"lowerIsBetter": false, "replicates": [604.5073265288792, 618.1500436899266, 662.9602223866568, 678.318290118431, 695.7147569496506, 12152.69618259544, 12400.069994750385, 12448.377581120953, 12475.750484990294, 12499.250044997296, 11087.05760010398, 11163.274387164829, 11218.775624487505, 11254.49354779035, 13920.651983700413, 805.923437273458, 817.0195765081896, 819.3527113580294, 820.4461988157999, 820.4625969989667, 643.3437893348805, 678.3453966921919, 761.5621017914722, 813.0040700142308, 814.4054839966827, 830.1822704635958, 837.1252041616495, 840.369722707969, 849.4818160921864, 858.0347109501811, 657.2474516678424, 838.5471845203583, 839.7061028639988, 840.1850205300848, 840.2479780596393, 508.77359574989146, 579.3945327133156, 619.5848781316529, 626.6302881300055, 630.6184758221256, 11486.368249746261, 11597.6520704379, 11673.708157296136, 11676.941615291955, 11711.297322160697, 10992.230543861933, 11248.156388270912, 11337.773244535145, 11531.538738450452, 11799.587014454539, 8460.407771456, 8789.121087891224, 9015.819683606356, 9100.362974591715, 9339.299552533586, 3405.7956522608724, 3423.298223864102, 3479.1128262292955, 3480.547528821237, 3485.337785820686, 48247.0, 48387.51612483865, 48477.0, 48593.0, 49208.015839683365, 9109.81780364389, 9234.722958311128, 9240.168384845396, 9270.44377337362, 9396.765080872896, 16383.180840957904, 16615.750763738553, 16636.334546618, 16645.0, 16648.25082871274, 6377.904331435032, 6495.512836537278, 6535.771248006392, 6550.475961923034, 6614.173228346457, 4061.329880569732, 4064.207479541461, 4083.0404854859084, 4089.9591004090175, 4155.896102597399, 2725.890964361443, 2755.0632784853246, 2756.944861102767, 2764.5853122031453, 2792.7905407094145, 547.887683024979, 550.3698265485996, 558.3997203006784, 560.8709996700782, 561.8483009587388, 533.4612041837772, 534.7486681259802, 556.168528050567, 563.1637019026742, 567.9716014199273, 7198.0, 7687.89157077605, 7775.650095745705, 7877.094134174643, 8150.4294699370475, 509.5465036117858, 519.5142541723501, 534.2707204665682, 535.1357557544537, 542.4385760737617, 3383.1880348716622, 3684.3552378333684, 3871.825767840454, 3898.9805050975133, 3904.5509766376663, 47792.5220747795, 48518.0, 48849.51150488521, 57860.0, 58757.0, 45679.0, 46377.0, 46408.5359146411, 46729.0, 46940.53059469361, 46850.0, 47075.0, 48051.27923081157, 48392.27411588759, 48811.75594122078, 7614.543127412373, 7817.140114587504, 7937.841243174988, 7993.360531157609, 8041.325699669377, 35585.46621800623, 36437.27125457529, 36617.633823661425, 37238.6276137246, 37505.62494375021, 47723.52276477191, 48184.518154818004, 48410.5158948406, 48476.7576162117, 48647.75676121597, 10937.945310273397, 10947.124230061416, 11085.113190944867, 11252.437378130897, 11324.037456815933, 11485.253458525169, 11641.359725215194, 11672.124590655565, 12009.339486328336, 12223.205491643015, 10441.582336706446, 10523.631672891719, 10718.624848130277, 11059.889401106208, 11211.327320360804, 10873.293235939638, 10976.286541374786, 11209.775804484028, 11312.86871312862, 11451.828222576502, 7045.0, 9488.525573721425, 10502.159827213958, 10580.947095264475, 10715.535426851711, 9031.187193152648, 9382.0, 9439.764005899633, 9663.226941844496, 9881.752956176153, 8657.22085012352, 8783.472991620523, 9068.818623627358, 9264.768380790534, 9266.351355405057], "unit": "score", "name": "yui.html", "value": 5886.610148639164}], "name": "dromaeo_css", "value": 6730.220096029891}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 105.0, 109.0, 109.0, 109.0, 97.0, 108.0, 108.0, 102.0], "unit": "score", "name": "ai-astar", "value": 106.4}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 150.0, 166.0, 130.0, 145.0, 151.0, 127.0, 170.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 164.0, 162.0, 161.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 94.0, 72.0, 73.0, 71.0, 105.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 140.0, 96.0, 96.0, 96.0, 141.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 65.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 87.0, 87.0, 85.0, 95.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [121.0, 129.0, 119.0, 116.0, 113.0, 120.0, 113.0, 115.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [143.0, 154.0, 150.0, 147.0, 155.0, 144.0, 165.0, 149.0, 151.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 69.0, 68.0, 71.0, 69.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1501.6999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [190.98548510313216], "unit": "score", "name": "DeltaBlue", "value": 346.19384800000006}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [2036.6598778004072], "unit": "score", "name": "RayTrace", "value": 363.33459900000014}, {"lowerIsBetter": false, "replicates": [804.5052292839904], "unit": "score", "name": "Earley", "value": 828.4135089999997}, {"lowerIsBetter": false, "replicates": [12204.819277108434], "unit": "score", "name": "Boyer", "value": 54.606543928923976}, {"lowerIsBetter": false, "replicates": [25725.0], "unit": "score", "name": "RegExp", "value": 35.412439261418825}, {"lowerIsBetter": false, "replicates": [584.7953216374269], "unit": "score", "name": "Splay", "value": 139.34960999999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19768.3706661123}]} 04:08:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19768.37"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1501.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6730.22"}}} 04:08:50 INFO - Return code: 0 04:08:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:08:50 INFO - # TBPL SUCCESS # 04:08:50 INFO - Running post-action listener: _resource_record_post_action 04:08:50 INFO - Running post-run listener: _resource_record_post_run 04:08:51 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 2715648; Write bytes: 318623744; Read time: 2504; Write time: 786000 04:08:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5500928; Read time: 0; Write time: 384 04:08:51 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 2715648; Write bytes: 313122816; Read time: 2504; Write time: 785616 04:08:51 INFO - Running post-run listener: _upload_blobber_files 04:08:51 INFO - Blob upload gear active. 04:08:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:08:51 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:08:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:53 INFO - (blobuploader) - INFO - Done attempting. 04:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:53 INFO - (blobuploader) - INFO - Done attempting. 04:08:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:53 INFO - Return code: 0 04:08:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:08:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e6584e59cb85af1422f19c7f4c420c05ae74add3ff7fcdab88f69d5377db5bb405f1df5ac14e38de8409deef9a73bbc7c4f33d2e5abe4f6293062d0d3e9a48a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de5e8dfac7d71c3f9e4b88a33af1c0c0f3ec9f60929df49be7968e29f399a51674d0cdf1d2409fb6e4a49b58850c7bacbfd1f8531997314f7df988a3bbdc2c5"} 04:08:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:08:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:08:53 INFO - Contents: 04:08:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e6584e59cb85af1422f19c7f4c420c05ae74add3ff7fcdab88f69d5377db5bb405f1df5ac14e38de8409deef9a73bbc7c4f33d2e5abe4f6293062d0d3e9a48a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de5e8dfac7d71c3f9e4b88a33af1c0c0f3ec9f60929df49be7968e29f399a51674d0cdf1d2409fb6e4a49b58850c7bacbfd1f8531997314f7df988a3bbdc2c5"} 04:08:53 INFO - Copying logs to upload dir... 04:08:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.951673 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-29 04:08:53.846440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:53.849726) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e6584e59cb85af1422f19c7f4c420c05ae74add3ff7fcdab88f69d5377db5bb405f1df5ac14e38de8409deef9a73bbc7c4f33d2e5abe4f6293062d0d3e9a48a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de5e8dfac7d71c3f9e4b88a33af1c0c0f3ec9f60929df49be7968e29f399a51674d0cdf1d2409fb6e4a49b58850c7bacbfd1f8531997314f7df988a3bbdc2c5"} build_url:https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/-fuTX7icTXCvl1YJEzw8Gw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e6584e59cb85af1422f19c7f4c420c05ae74add3ff7fcdab88f69d5377db5bb405f1df5ac14e38de8409deef9a73bbc7c4f33d2e5abe4f6293062d0d3e9a48a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1de5e8dfac7d71c3f9e4b88a33af1c0c0f3ec9f60929df49be7968e29f399a51674d0cdf1d2409fb6e4a49b58850c7bacbfd1f8531997314f7df988a3bbdc2c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:53.877031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:53.877349) ========= 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=ccb4611811c763f2fad71465000001de-1451384038.797782-326035143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 04:08:53.962149) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:08:53.962465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 04:08:53.962765) ========= ========= Total master_lag: 0.25 =========