builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1451475864.82 results: success (0) buildid: 20151230013009 builduid: f8fa711fb644426bb22b3d81b9481ae6 revision: cb7ddeee6364905a0184e7ceccfab9d1dfea25f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.820424) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.820906) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.821275) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006410 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.875567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.875924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.900459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.900745) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004758 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.960284) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.960595) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.961042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:24.961376) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 03:44:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-30 03:44:25 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.156882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.157231) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.206799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.207194) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cb7ddeee6364905a0184e7ceccfab9d1dfea25f9 --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 cb7ddeee6364905a0184e7ceccfab9d1dfea25f9 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 03:44:25,392 truncating revision to first 12 chars 2015-12-30 03:44:25,392 Setting DEBUG logging. 2015-12-30 03:44:25,392 attempt 1/10 2015-12-30 03:44:25,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/cb7ddeee6364?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 03:44:25,804 unpacking tar archive at: mozilla-inbound-cb7ddeee6364/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684558 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.904284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.904577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.913878) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.914267) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 03:44:25.914741) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 03:44:25.915050) ========= /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=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:26 INFO - MultiFileLogger online at 20151230 03:44:26 in /builds/slave/test-pgo 03:44:26 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:44:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:44:26 INFO - {'append_to_log': False, 03:44:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:44:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:44:26 INFO - 'branch': 'Mozilla-Inbound', 03:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:26 INFO - 'config_files': ('talos/linux_config.py',), 03:44:26 INFO - 'default_actions': ('clobber', 03:44:26 INFO - 'read-buildbot-config', 03:44:26 INFO - 'download-and-extract', 03:44:26 INFO - 'populate-webroot', 03:44:26 INFO - 'create-virtualenv', 03:44:26 INFO - 'install', 03:44:26 INFO - 'run-tests'), 03:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:26 INFO - 'download_minidump_stackwalk': True, 03:44:26 INFO - 'download_symbols': 'ondemand', 03:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:26 INFO - 'installer_path': 'installer.exe', 03:44:26 INFO - 'log_level': 'info', 03:44:26 INFO - 'log_name': 'talos', 03:44:26 INFO - 'log_to_console': True, 03:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:26 INFO - 'opt_config_files': (), 03:44:26 INFO - 'pip_index': False, 03:44:26 INFO - 'sps_profile': False, 03:44:26 INFO - 'sps_profile_interval': 0, 03:44:26 INFO - 'suite': 'dromaeojs', 03:44:26 INFO - 'system_bits': '32', 03:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:26 INFO - 'title': 'talos-linux64-ix-031', 03:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:26 INFO - 'use_talos_json': True, 03:44:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:26 INFO - 'work_dir': 'build'} 03:44:26 INFO - ##### 03:44:26 INFO - ##### Running clobber step. 03:44:26 INFO - ##### 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: clobber 03:44:26 INFO - rmtree: /builds/slave/test-pgo/build 03:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:44:26 INFO - Running post-action listener: _resource_record_post_action 03:44:26 INFO - ##### 03:44:26 INFO - ##### Running read-buildbot-config step. 03:44:26 INFO - ##### 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: read_buildbot_config 03:44:26 INFO - Using buildbot properties: 03:44:26 INFO - { 03:44:26 INFO - "project": "", 03:44:26 INFO - "product": "firefox", 03:44:26 INFO - "script_repo_revision": "production", 03:44:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:44:26 INFO - "repository": "", 03:44:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:44:26 INFO - "buildid": "20151230013009", 03:44:26 INFO - "pgo_build": "True", 03:44:26 INFO - "basedir": "/builds/slave/test-pgo", 03:44:26 INFO - "buildnumber": 1391, 03:44:26 INFO - "slavename": "talos-linux64-ix-031", 03:44:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:26 INFO - "platform": "ubuntu64_hw", 03:44:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:44:26 INFO - "branch": "mozilla-inbound", 03:44:26 INFO - "repo_path": "integration/mozilla-inbound", 03:44:26 INFO - "revision": "cb7ddeee6364905a0184e7ceccfab9d1dfea25f9", 03:44:26 INFO - "stage_platform": "linux64-pgo", 03:44:26 INFO - "builduid": "f8fa711fb644426bb22b3d81b9481ae6", 03:44:26 INFO - "slavebuilddir": "test" 03:44:26 INFO - } 03:44:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:44:26 INFO - Running post-action listener: _resource_record_post_action 03:44:26 INFO - ##### 03:44:26 INFO - ##### Running download-and-extract step. 03:44:26 INFO - ##### 03:44:26 INFO - Running pre-action listener: _resource_record_pre_action 03:44:26 INFO - Running main action method: download_and_extract 03:44:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:26 INFO - https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/test_packages.json 03:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/test_packages.json 03:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:44:34 INFO - Downloaded 1302 bytes. 03:44:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:44:34 INFO - Using the following test package requirements: 03:44:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:44:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'jsshell-linux-x86_64.zip'], 03:44:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:44:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:44:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:44:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:44:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:44:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:34 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:44:34 INFO - https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:39 INFO - Downloaded 23199715 bytes. 03:44: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:44:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44: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:44:40 INFO - Return code: 0 03:44: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:44: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:44:40 INFO - https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:44 INFO - Downloaded 23199715 bytes. 03:44:44 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:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:44:44 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:44:45 INFO - Return code: 0 03:44: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:44:45 INFO - https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:46 INFO - Downloaded 11132270 bytes. 03:44:46 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:44:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:44:46 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:44:46 INFO - Return code: 0 03:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:46 INFO - https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:44:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:44:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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:44:47 INFO - Downloaded 54950348 bytes. 03:44:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - mkdir: /builds/slave/test-pgo/properties 03:44:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:44:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:44:47 INFO - Contents: 03:44:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:44:47 INFO - Running post-action listener: _resource_record_post_action 03:44:47 INFO - Running post-action listener: set_extra_try_arguments 03:44:47 INFO - ##### 03:44:47 INFO - ##### Running populate-webroot step. 03:44:47 INFO - ##### 03:44:47 INFO - Running pre-action listener: _resource_record_pre_action 03:44:47 INFO - Running main action method: populate_webroot 03:44:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:47 INFO - '--tppagecycles', 03:44:47 INFO - '7'], 03:44:47 INFO - 'tests': ['tsvgm']}}, 03:44:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:44:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:44:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:44:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:44:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'tests': ['damp', 'tps']}, 03:44:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['damp', 'tps']}, 03:44:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:44:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:47 INFO - 'other': {'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'other_l64': {'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:44:47 INFO - 'ts_paint', 03:44:47 INFO - 'tpaint', 03:44:47 INFO - 'sessionrestore', 03:44:47 INFO - 'sessionrestore_no_auto_restore']}, 03:44:47 INFO - 'svgr': {'tests': ['tsvgx', 03:44:47 INFO - 'tsvgr_opacity', 03:44:47 INFO - 'tart', 03:44:47 INFO - 'tscrollx', 03:44:47 INFO - 'cart']}, 03:44:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['tsvgx', 03:44:47 INFO - 'tsvgr_opacity', 03:44:47 INFO - 'tart', 03:44:47 INFO - 'tscrollx', 03:44:47 INFO - 'cart']}, 03:44:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'tests': ['tp5o']}, 03:44:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'talos_options': ['--e10s'], 03:44:47 INFO - 'tests': ['tp5o']}, 03:44:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'talos_options': ['--xperf_path', 03:44:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:47 INFO - 'tests': ['tp5n']}, 03:44:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:44:47 INFO - 'talos_options': ['--e10s', 03:44:47 INFO - '--xperf_path', 03:44:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:47 INFO - 'tests': ['tp5n']}}, 03:44:47 INFO - 'talos.zip': {'path': '', 03:44:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:47 INFO - Running post-action listener: _resource_record_post_action 03:44:47 INFO - ##### 03:44:47 INFO - ##### Running create-virtualenv step. 03:44:47 INFO - ##### 03:44:47 INFO - Running pre-action listener: _resource_record_pre_action 03:44:47 INFO - Running main action method: create_virtualenv 03:44:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:44:47 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:44:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:44:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:47 INFO - Using real prefix '/usr' 03:44:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:44:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:50 INFO - Installing pip.................done. 03:44:50 INFO - Return code: 0 03:44:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:44: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:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:44: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:44: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:44:50 INFO - Using env: {'DISPLAY': ':0', 03:44:50 INFO - 'HOME': '/home/cltbld', 03:44:50 INFO - 'LANG': 'en_US.UTF-8', 03:44:50 INFO - 'LANGUAGE': 'en_US:en', 03:44:50 INFO - 'LOGNAME': 'cltbld', 03:44:50 INFO - 'MAIL': '/var/mail/cltbld', 03:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:50 INFO - 'MOZ_NO_REMOTE': '1', 03:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:50 INFO - 'NO_EM_RESTART': '1', 03:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:44:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:44:50 INFO - 'SHELL': '/bin/bash', 03:44:50 INFO - 'SHLVL': '1', 03:44:50 INFO - 'TERM': 'linux', 03:44:50 INFO - 'TMOUT': '86400', 03:44:50 INFO - 'USER': 'cltbld', 03:44:50 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:50 INFO - '_': '/tools/buildbot/bin/python'} 03:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44: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:44:50 INFO - Cleaning up... 03:44:50 INFO - Return code: 0 03:44:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:44: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:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:44: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:44: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:44:50 INFO - Using env: {'DISPLAY': ':0', 03:44:50 INFO - 'HOME': '/home/cltbld', 03:44:50 INFO - 'LANG': 'en_US.UTF-8', 03:44:50 INFO - 'LANGUAGE': 'en_US:en', 03:44:50 INFO - 'LOGNAME': 'cltbld', 03:44:50 INFO - 'MAIL': '/var/mail/cltbld', 03:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:50 INFO - 'MOZ_NO_REMOTE': '1', 03:44:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:50 INFO - 'NO_EM_RESTART': '1', 03:44:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:44:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:44:50 INFO - 'SHELL': '/bin/bash', 03:44:50 INFO - 'SHLVL': '1', 03:44:50 INFO - 'TERM': 'linux', 03:44:50 INFO - 'TMOUT': '86400', 03:44:50 INFO - 'USER': 'cltbld', 03:44:50 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:50 INFO - '_': '/tools/buildbot/bin/python'} 03:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:50 INFO - Downloading/unpacking psutil>=0.7.1 03:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:50 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:44:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:44: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:44:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:52 INFO - Installing collected packages: psutil 03:44:52 INFO - Running setup.py install for psutil 03:44:52 INFO - building 'psutil._psutil_linux' extension 03:44:52 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:44:52 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:44:52 INFO - building 'psutil._psutil_posix' extension 03:44:52 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:44: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:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:53 INFO - Successfully installed psutil 03:44:53 INFO - Cleaning up... 03:44:53 INFO - Return code: 0 03:44:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44: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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:44: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:44: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:44:53 INFO - Using env: {'DISPLAY': ':0', 03:44:53 INFO - 'HOME': '/home/cltbld', 03:44:53 INFO - 'LANG': 'en_US.UTF-8', 03:44:53 INFO - 'LANGUAGE': 'en_US:en', 03:44:53 INFO - 'LOGNAME': 'cltbld', 03:44:53 INFO - 'MAIL': '/var/mail/cltbld', 03:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:53 INFO - 'MOZ_NO_REMOTE': '1', 03:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:53 INFO - 'NO_EM_RESTART': '1', 03:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:44:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:44:53 INFO - 'SHELL': '/bin/bash', 03:44:53 INFO - 'SHLVL': '1', 03:44:53 INFO - 'TERM': 'linux', 03:44:53 INFO - 'TMOUT': '86400', 03:44:53 INFO - 'USER': 'cltbld', 03:44:53 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:53 INFO - '_': '/tools/buildbot/bin/python'} 03:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:44: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:44: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:44: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:44: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:44: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:44: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:44:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:44:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:44:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:44: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:44:55 INFO - Installing collected packages: mozsystemmonitor 03:44:55 INFO - Running setup.py install for mozsystemmonitor 03:44:55 INFO - Successfully installed mozsystemmonitor 03:44:55 INFO - Cleaning up... 03:44:55 INFO - Return code: 0 03:44:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:55 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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:44:55 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:44:55 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:44:55 INFO - Using env: {'DISPLAY': ':0', 03:44:55 INFO - 'HOME': '/home/cltbld', 03:44:55 INFO - 'LANG': 'en_US.UTF-8', 03:44:55 INFO - 'LANGUAGE': 'en_US:en', 03:44:55 INFO - 'LOGNAME': 'cltbld', 03:44:55 INFO - 'MAIL': '/var/mail/cltbld', 03:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:55 INFO - 'MOZ_NO_REMOTE': '1', 03:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:55 INFO - 'NO_EM_RESTART': '1', 03:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:44:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:44:55 INFO - 'SHELL': '/bin/bash', 03:44:55 INFO - 'SHLVL': '1', 03:44:55 INFO - 'TERM': 'linux', 03:44:55 INFO - 'TMOUT': '86400', 03:44:55 INFO - 'USER': 'cltbld', 03:44:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:55 INFO - '_': '/tools/buildbot/bin/python'} 03:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:44:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:44: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:44: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:44: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:44: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:44: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:44: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:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:44:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:44: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:44: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:44: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:44: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:44: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:44: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:44:57 INFO - Downloading docopt-0.6.1.tar.gz 03:44:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:44:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:44:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:44:57 INFO - Running setup.py install for blobuploader 03:44:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:44:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:44:58 INFO - Running setup.py install for requests 03:44:58 INFO - Running setup.py install for docopt 03:44:58 INFO - Successfully installed blobuploader requests docopt 03:44:58 INFO - Cleaning up... 03:44:58 INFO - Return code: 0 03:44:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:58 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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:44:58 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:44:58 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:44:58 INFO - Using env: {'DISPLAY': ':0', 03:44:58 INFO - 'HOME': '/home/cltbld', 03:44:58 INFO - 'LANG': 'en_US.UTF-8', 03:44:58 INFO - 'LANGUAGE': 'en_US:en', 03:44:58 INFO - 'LOGNAME': 'cltbld', 03:44:58 INFO - 'MAIL': '/var/mail/cltbld', 03:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:58 INFO - 'MOZ_NO_REMOTE': '1', 03:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:58 INFO - 'NO_EM_RESTART': '1', 03:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 03:44:58 INFO - 'SHELL': '/bin/bash', 03:44:58 INFO - 'SHLVL': '1', 03:44:58 INFO - 'TERM': 'linux', 03:44:58 INFO - 'TMOUT': '86400', 03:44:58 INFO - 'USER': 'cltbld', 03:44:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:58 INFO - '_': '/tools/buildbot/bin/python'} 03:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:44:58 INFO - Running setup.py (path:/tmp/pip-p8mE5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:44:58 INFO - Running setup.py (path:/tmp/pip-cvhJca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:44:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:44:58 INFO - Running setup.py (path:/tmp/pip-m3QYdp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:44:59 INFO - Running setup.py (path:/tmp/pip-EGae4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:44:59 INFO - Running setup.py (path:/tmp/pip-r3r4AD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:44:59 INFO - Running setup.py (path:/tmp/pip-Lgv0ng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:44:59 INFO - Running setup.py (path:/tmp/pip-NBN4yh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:44:59 INFO - Running setup.py (path:/tmp/pip-5zgqGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:44:59 INFO - Running setup.py (path:/tmp/pip-at4flr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:44:59 INFO - Running setup.py (path:/tmp/pip-HW102o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:44:59 INFO - Running setup.py (path:/tmp/pip-ISq22J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:44:59 INFO - Running setup.py (path:/tmp/pip-nA4COA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:44:59 INFO - Running setup.py (path:/tmp/pip-zAT0ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:44:59 INFO - Running setup.py (path:/tmp/pip-WCj77h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:44:59 INFO - Running setup.py (path:/tmp/pip-9xcApc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:44:59 INFO - Running setup.py (path:/tmp/pip-EJXC6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:44:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:44:59 INFO - Running setup.py (path:/tmp/pip-886hvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:45:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:00 INFO - Running setup.py install for manifestparser 03:45:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Running setup.py install for mozcrash 03:45:00 INFO - Running setup.py install for mozdebug 03:45:00 INFO - Running setup.py install for mozdevice 03:45:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Running setup.py install for mozfile 03:45:00 INFO - Running setup.py install for mozhttpd 03:45:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Running setup.py install for mozinfo 03:45:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Running setup.py install for mozInstall 03:45:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:45:00 INFO - Running setup.py install for mozleak 03:45:00 INFO - Running setup.py install for mozlog 03:45:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Running setup.py install for moznetwork 03:45:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Running setup.py install for mozprocess 03:45:01 INFO - Running setup.py install for mozprofile 03:45:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Running setup.py install for mozrunner 03:45:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Running setup.py install for mozscreenshot 03:45:01 INFO - Running setup.py install for moztest 03:45:01 INFO - Running setup.py install for mozversion 03:45:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:45:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:01 INFO - Cleaning up... 03:45:01 INFO - Return code: 0 03:45:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:01 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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:45:01 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:45:01 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:45:01 INFO - Using env: {'DISPLAY': ':0', 03:45:01 INFO - 'HOME': '/home/cltbld', 03:45:01 INFO - 'LANG': 'en_US.UTF-8', 03:45:01 INFO - 'LANGUAGE': 'en_US:en', 03:45:01 INFO - 'LOGNAME': 'cltbld', 03:45:01 INFO - 'MAIL': '/var/mail/cltbld', 03:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:01 INFO - 'MOZ_NO_REMOTE': '1', 03:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:01 INFO - 'NO_EM_RESTART': '1', 03:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:45:01 INFO - 'SHELL': '/bin/bash', 03:45:01 INFO - 'SHLVL': '1', 03:45:01 INFO - 'TERM': 'linux', 03:45:01 INFO - 'TMOUT': '86400', 03:45:01 INFO - 'USER': 'cltbld', 03:45:01 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:01 INFO - '_': '/tools/buildbot/bin/python'} 03:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:45:02 INFO - Running setup.py (path:/tmp/pip-Bxu6XT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:45:02 INFO - Running setup.py (path:/tmp/pip-A8LnRy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:45:02 INFO - Running setup.py (path:/tmp/pip-EzFhCI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:45:02 INFO - Running setup.py (path:/tmp/pip-_7zM5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:45:02 INFO - Running setup.py (path:/tmp/pip-0PfJAy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:45:02 INFO - Running setup.py (path:/tmp/pip-_dea7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:45:02 INFO - Running setup.py (path:/tmp/pip-AhkhKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:45:02 INFO - Running setup.py (path:/tmp/pip-2bGQVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:45:02 INFO - Running setup.py (path:/tmp/pip-EbaWj7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:45:02 INFO - Running setup.py (path:/tmp/pip-kFdcOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:45:02 INFO - Running setup.py (path:/tmp/pip-UNOOh6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:45:02 INFO - Running setup.py (path:/tmp/pip-ITDo6X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:45:02 INFO - Running setup.py (path:/tmp/pip-tCnuYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:45:02 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:45:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:45:02 INFO - Running setup.py (path:/tmp/pip-7sXjmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:45:03 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:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:45:03 INFO - Running setup.py (path:/tmp/pip-t0jdRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:45:03 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:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:45:03 INFO - Running setup.py (path:/tmp/pip-UWwpxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:45:03 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:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:45:03 INFO - Running setup.py (path:/tmp/pip-DCglbU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:45:03 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:45:03 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:45:03 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:45:03 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:45:03 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:45:03 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:45:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:04 INFO - Downloading blessings-1.5.1.tar.gz 03:45:05 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:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:05 INFO - Installing collected packages: blessings 03:45:05 INFO - Running setup.py install for blessings 03:45:05 INFO - Successfully installed blessings 03:45:05 INFO - Cleaning up... 03:45:05 INFO - Return code: 0 03:45:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:45:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:45:05 INFO - Reading from file tmpfile_stdout 03:45:05 INFO - Current package versions: 03:45:05 INFO - argparse == 1.2.1 03:45:05 INFO - blessings == 1.5.1 03:45:05 INFO - blobuploader == 1.2.4 03:45:05 INFO - docopt == 0.6.1 03:45:05 INFO - manifestparser == 1.1 03:45:05 INFO - mozInstall == 1.12 03:45:05 INFO - mozcrash == 0.16 03:45:05 INFO - mozdebug == 0.1 03:45:05 INFO - mozdevice == 0.47 03:45:05 INFO - mozfile == 1.2 03:45:05 INFO - mozhttpd == 0.7 03:45:05 INFO - mozinfo == 0.9 03:45:05 INFO - mozleak == 0.1 03:45:05 INFO - mozlog == 3.1 03:45:05 INFO - moznetwork == 0.27 03:45:05 INFO - mozprocess == 0.22 03:45:05 INFO - mozprofile == 0.28 03:45:05 INFO - mozrunner == 6.11 03:45:05 INFO - mozscreenshot == 0.1 03:45:05 INFO - mozsystemmonitor == 0.0 03:45:05 INFO - moztest == 0.7 03:45:05 INFO - mozversion == 1.4 03:45:05 INFO - psutil == 3.1.1 03:45:05 INFO - requests == 1.2.3 03:45:05 INFO - wsgiref == 0.1.2 03:45:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -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:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 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:45:05 INFO - Cleaning up... 03:45:05 INFO - Return code: 0 03:45:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:05 INFO - Downloading/unpacking jsonschema 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:07 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:45:07 INFO - Downloading/unpacking functools32 (from jsonschema) 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:07 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:45:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:07 INFO - warning: no files found matching '*.txt' 03:45:07 INFO - no previously-included directories found matching 'build' 03:45:07 INFO - no previously-included directories found matching 'dist' 03:45:07 INFO - no previously-included directories found matching '.git*' 03:45:07 INFO - Installing collected packages: jsonschema, functools32 03:45:07 INFO - Running setup.py install for functools32 03:45:07 INFO - warning: no files found matching '*.txt' 03:45:07 INFO - no previously-included directories found matching 'build' 03:45:07 INFO - no previously-included directories found matching 'dist' 03:45:07 INFO - no previously-included directories found matching '.git*' 03:45:08 INFO - Successfully installed jsonschema functools32 03:45:08 INFO - Cleaning up... 03:45:08 INFO - Return code: 0 03:45:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0289bfaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2894230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', '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:45:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:45:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:45:08 INFO - Using env: {'DISPLAY': ':0', 03:45:08 INFO - 'HOME': '/home/cltbld', 03:45:08 INFO - 'LANG': 'en_US.UTF-8', 03:45:08 INFO - 'LANGUAGE': 'en_US:en', 03:45:08 INFO - 'LOGNAME': 'cltbld', 03:45:08 INFO - 'MAIL': '/var/mail/cltbld', 03:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:08 INFO - 'MOZ_NO_REMOTE': '1', 03:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:08 INFO - 'NO_EM_RESTART': '1', 03:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:45:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:45:08 INFO - 'SHELL': '/bin/bash', 03:45:08 INFO - 'SHLVL': '1', 03:45:08 INFO - 'TERM': 'linux', 03:45:08 INFO - 'TMOUT': '86400', 03:45:08 INFO - 'USER': 'cltbld', 03:45:08 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:08 INFO - '_': '/tools/buildbot/bin/python'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Downloading/unpacking flake8 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:45:09 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:45:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:45: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:45: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:45: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:45: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:45: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:45: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:45:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:45:10 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:45:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:45:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:10 INFO - no previously-included directories found matching 'docs/_build' 03:45:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:45:10 INFO - Running setup.py install for pep8 03:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:45:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:45:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:45:10 INFO - no previously-included directories found matching 'docs/_build' 03:45:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:45:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:45:10 INFO - Cleaning up... 03:45:10 INFO - Return code: 0 03:45:10 INFO - Running post-action listener: _resource_record_post_action 03:45:10 INFO - Running post-action listener: _start_resource_monitoring 03:45:10 INFO - Starting resource monitoring. 03:45:10 INFO - ##### 03:45:10 INFO - ##### Running install step. 03:45:10 INFO - ##### 03:45:10 INFO - Running pre-action listener: _resource_record_pre_action 03:45:10 INFO - Running main action method: install 03:45:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:45:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:45:11 INFO - Reading from file tmpfile_stdout 03:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:45:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:45:11 INFO - Reading from file tmpfile_stdout 03:45:11 INFO - Output received: 03:45:11 INFO - Usage: mozinstall [options] installer 03:45:11 INFO - Options: 03:45:11 INFO - -h, --help show this help message and exit 03:45:11 INFO - -d DEST, --destination=DEST 03:45:11 INFO - Directory to install application into. [default: 03:45:11 INFO - "/builds/slave/test-pgo"] 03:45:11 INFO - --app=APP Application being installed. [default: firefox] 03:45:11 INFO - mkdir: /builds/slave/test-pgo/build/application 03:45:11 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:45:11 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:45:26 INFO - Reading from file tmpfile_stdout 03:45:26 INFO - Output received: 03:45:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:45:26 INFO - Running post-action listener: _resource_record_post_action 03:45:26 INFO - ##### 03:45:26 INFO - ##### Running run-tests step. 03:45:26 INFO - ##### 03:45:26 INFO - Running pre-action listener: _resource_record_pre_action 03:45:26 INFO - Running main action method: run_tests 03:45:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:45:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:45:26 INFO - Python 2.7.3 03:45:26 INFO - Return code: 0 03:45:26 INFO - grabbing minidump binary from tooltool 03:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:26 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 0x29267f0>, '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 0x28922d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2892760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:45:26 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:45:26 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:45:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:27 INFO - Return code: 0 03:45:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:45:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:45:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:45:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:45:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:45:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:45:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:45:27 INFO - Return code: 0 03:45:27 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/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:45:27 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/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:45:27 INFO - Using env: {'DISPLAY': ':0', 03:45:27 INFO - 'HOME': '/home/cltbld', 03:45:28 INFO - 'LANG': 'en_US.UTF-8', 03:45:28 INFO - 'LANGUAGE': 'en_US:en', 03:45:28 INFO - 'LOGNAME': 'cltbld', 03:45:28 INFO - 'MAIL': '/var/mail/cltbld', 03:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:28 INFO - 'MOZ_NO_REMOTE': '1', 03:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:28 INFO - 'NO_EM_RESTART': '1', 03:45:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:45:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:45:28 INFO - 'SHELL': '/bin/bash', 03:45:28 INFO - 'SHLVL': '1', 03:45:28 INFO - 'TERM': 'linux', 03:45:28 INFO - 'TMOUT': '86400', 03:45:28 INFO - 'USER': 'cltbld', 03:45:28 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431', 03:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:28 INFO - '_': '/tools/buildbot/bin/python'} 03:45:28 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/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:45:28 INFO - mozversion application_buildid: 20151230013009 03:45:28 INFO - mozversion application_changeset: cb7ddeee6364905a0184e7ceccfab9d1dfea25f9 03:45:28 INFO - mozversion application_display_name: Nightly 03:45:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:28 INFO - mozversion application_name: Firefox 03:45:28 INFO - mozversion application_remotingname: firefox 03:45:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:45:28 INFO - mozversion application_vendor: Mozilla 03:45:28 INFO - mozversion application_version: 46.0a1 03:45:28 INFO - mozversion platform_buildid: 20151230013009 03:45:28 INFO - mozversion platform_changeset: cb7ddeee6364905a0184e7ceccfab9d1dfea25f9 03:45:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:45:28 INFO - mozversion platform_version: 46.0a1 03:45:28 INFO - using testdate: 1451475928 03:45:28 INFO - actual date: 1451475928 03:45:28 INFO - starting webserver on 'localhost:46165' 03:45:28 INFO - SUITE-START | Running 3 tests 03:45:28 INFO - TEST-START | dromaeo_css 03:45:28 INFO - operating with platform_type : linux_ 03:45:28 INFO - Initialising browser for dromaeo_css test... 03:45:28 INFO - TEST-INFO | started process 18789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_joXmP/profile http://localhost:46165/getInfo.html) 03:45:32 INFO - PROCESS | 18789 | __metrics Screen width/height:1600/1200 03:45:32 INFO - PROCESS | 18789 | colorDepth:24 03:45:32 INFO - PROCESS | 18789 | Browser inner width/height: 1024/697 03:45:32 INFO - PROCESS | 18789 | __metrics 03:45:32 INFO - PROCESS | 18789 | 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:45:32 INFO - PROCESS | 18789 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:33 INFO - TEST-INFO | 18789: exit 0 03:45:33 INFO - Browser initialized. 03:45:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:33 INFO - TEST-INFO | started process 18879 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_joXmP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:45 INFO - PROCESS | 18879 | RSS: Main: 148492288 03:45:45 INFO - PROCESS | 18879 | 03:46:36 INFO - PROCESS | 18879 | 1451475996088 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:48:45 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46165/tests/dromaeo/cssquery-ext.html) 03:48:47 INFO - PROCESS | 18879 | RSS: Main: 254267392 03:48:47 INFO - PROCESS | 18879 | 03:51:49 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-ext.html (next: http://localhost:46165/tests/dromaeo/cssquery-jquery.html) 03:51:50 INFO - PROCESS | 18879 | RSS: Main: 227786752 03:51:50 INFO - PROCESS | 18879 | 03:54:52 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46165/tests/dromaeo/cssquery-mootools.html) 03:54:52 INFO - PROCESS | 18879 | RSS: Main: 226738176 03:54:52 INFO - PROCESS | 18879 | 03:57:54 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46165/tests/dromaeo/cssquery-prototype.html) 03:57:55 INFO - PROCESS | 18879 | RSS: Main: 213164032 03:57:55 INFO - PROCESS | 18879 | 04:00:57 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46165/tests/dromaeo/cssquery-yui.html) 04:00:58 INFO - PROCESS | 18879 | RSS: Main: 219107328 04:00:58 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | Cycle 1(1): loaded http://localhost:46165/tests/dromaeo/cssquery-yui.html (next: http://localhost:46165/tests/dromaeo/cssquery-dojo.html) 04:04:00 INFO - PROCESS | 18879 | RSS: Main: 245706752 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | __start_tp_report 04:04:00 INFO - PROCESS | 18879 | _x_x_mozilla_page_load 04:04:00 INFO - PROCESS | 18879 | _x_x_mozilla_page_load_details 04:04:00 INFO - PROCESS | 18879 | |i|pagename|runs| 04:04:00 INFO - PROCESS | 18879 | |0;dojo.html;3159.352332771782;3202.823844688541;3236.2880166363393;3237.854296556655;3259.934801303974;5195.428502864682;5317.441668624797;5416.052190866598;5449.373322067959;5501.587380946425;5266.841994740154;5384.326959130109;5386.057439948013;5417.26866872972;5484.862878428041;4927.187014142671;4948.406191257036;4952.727599981999;4959.008198360342;4979.875503112415;5010.498950104979;5047.192449208127;5094;5120.02719483297;5130.2817605535065;4767.094252092092;4804.687695299812;4916;4921.335619691332;4945.629077819178;4943.456219815817;4944.233643785183;4948.975255123702;4952.777125029383;4996.325496058022;4810.11012962603;4901.6964722563125;4930.778114984834;4944.258361245806;4969.155243608595;5183.481651834786;5189.636725429222;5273.050850846846;5301.761420736076;5304.761285742113;5760.164776107441;5796.681182534959;5798.594098413113;5799.710014499258;5803.361630220672;5810.6513609183585;5840.795572154997;5842.503387212049;5842.824715258549;5843.707814609253;5305.283786688786;5376.139817629239;5406.783728650849;5413.918791218135;5489.615726899079;5952.672603006789;5956.940430595725;5964.642121472725;6010.128531362928;6017.608855424383;5693.28833895763;5742.856428589319;5744.482996530249;5746.367899531048;5750.913736293959;5694.658320500783;5802.448767367094;5808.5062769665055;5888.705564721832;5901.380355062743;5725.484706376446;5731.254936858182;5736.110902810071;5751.194832723422;5768.653880767168;5732.656040637575;5734.2258795062135;5744.224529688438;5751.252337196138;5755.1367294906095;4373.059792144704;4427.75647339393;4430.335449682509;4434.911301773946;4460.174867649495;3920.1179734559496;3938.0942383252013;4002.45966794479;4026.013626661487;4041.413994970713;5343.038253114477;5354.4645535446925;5356.651817631841;5359.3032905722;5360.597955153379;5631.662100273915;5727.455891690282;5797.942020579824;5802.854928626733;5804.535637149018;5230.8169214077325;5308.575313974873;5339.893202135935;5373.274607927958;5414.269073675082;5023.095842748267;5048.192289233705;5050.4697006814495;5054.292399064134;5098.031374038921;5726.341470730836;5790;5927.525797936155;5939.584229103922;5949.762009519657;5660.773569057192;5723.198752174616;5775.191473193672;5780.075187969905;5832.650040997553;5908.645481270965;5915.994280972331;5916.26046744157;5916.497097746567;5924.052151655715;5635.718214089197;5746.339170995389;5767.653940763567;5783.363829978614;5788.594798364074;5780.450857168562;5853.2976042875125;5857.297124345106;5869.706514674334;5870.559708022;5540.196671482693;5630.211770352236;5642.830715078554;5646.435356464321;5648.745806438638;5573.108302671553;5602.299712535933;5630.296212973379;5635.211070450058;5640.294963129609;5417.133258678593;5503.394626591152;5517.834464966058;5596.300462442195;5632.7746890123935;5542;5560.5829562783765;5565.777368905198;5574.526165275997;5596.804111856066;5393.217983392307;5431.565474762088;5434.2935418395355;5437.13005919051;5452.154915988028 04:04:00 INFO - PROCESS | 18879 | |1;ext.html;537.9166229234469;538.8625900395399;544.0261931143253;560.6608002158692;575.8387651457591;28657.140285791433;29293.707062929363;35392.823035884816;36003;36134.819325903336;39489.802550987275;39649;39748;39800;39858;7384.076990376203;8255.380846436527;8408.369372297071;8416.495010299372;8419.83160336793;7406.8888966665545;9984.550695218697;10189.439580823051;10195.745106372364;10205.132563732055;9861.359011664219;9912.504374781269;9959.850602240973;9961.551730172123;9966.202703783716;7492;7653;9871.062249086326;9972.252081093911;10011.299209055369;9695.127438530566;9819.803603927881;9825.803483930282;9827.77152855893;9828.655997040141;36297.45553816695;36923.63076369229;36969.44545831814;36983.445248321295;37054.258914821825;3113.315070684446;3151.6060492438446;3202.039388183559;3212.9114580218134;3249.5938007749032;28199.43601127966;30590.694093059006;30806.691933080605;30825.537616935762;30956;3848.0956975110826;3849.826757795906;3873.205992771503;3906.160175562239;3975.840966361342;267716;270252;271440;271563.999999998;271966;52470;52594.47405525972;52596.21105683418;52690;55738;49063.50936490661;62455;63244;63353;63481.365186347546;15339.539813805604;15689.68620627604;15732.449364272195;15738.213089345487;15740.527784166494;11366.886331136582;11528.769424611628;12056.698582535331;12327.568535101229;12382.442790074469;18371.90814045921;18493.53766155857;18499.445016649523;18525.166367513495;18572.628547428976;7171.748988785367;7475.813104672318;7505.812354691067;7604.201558836353;7644.388448924073;887.1217494680349;980.5685498380832;1052.2108418685987;1061.5117046158698;1085.3433672628105;28377.29056773597;28521.286967825556;28532.572011419845;28565.28586785347;28898.27754306159;954.022127319503;1051.805415998043;1094.0372472224392;1123.915706322029;1125.8536390269212;15127.243637818285;15273.770893436607;15608.531744047697;16148.838511614733;16241.187940603158;327252;332683;333129;333304;333357;51963.22055169175;52866;53073.734631326595;53092.46907530875;53149.7342513285;1373.4506197520873;1380.5513208207374;1398.4755716606273;1399.2024546008881;1402.8036074949516;27968.720312796613;29039.41921161607;29064.709352907044;29355.706442935298;29492;44864.55135448735;45008.549914500436;45296;45342.31986520139;45358.77320613376;296029;298775;298831;298955;299293;28818.567721484615;30701.23246918845;30979.535306969963;31276.687233127377;31557.684423155475;36783.63216367802;37625.4356184652;37862.62137378591;38457.23085538329;38458.80770596129;30392.240193995327;32604.673953260164;34949;36318;36723;29707;34266.31467370688;34436.31127377489;35419.29161416809;35869.641303587676;32784.50823237606;32982.175445614055;33249.66750332466;35819.64180358163;36562.817185914966;27834.5824812632;28751.712482874904;29627;30821.22946926345;31249.531257031616;23989.76010239875;24009.759902400754;24238.87880560586;24308;24388.51222975495 04:04:00 INFO - PROCESS | 18879 | |2;jquery.html;354.9538559987203;357.20165430263376;358.4998926497536;362.7696412777886;364.5898364340117;14047.157170569773;14226.146431214134;16296.696264298856;16559.420420285292;17252;15524.534263972071;16091.678166436664;16283.51149465515;16654.1672916354;16671.83328166718;5251.422343542217;5359.464053594648;5375.569954403658;5387.892242155154;5395.892082158354;3993.620606042436;4088.8568900088503;5273.57811375091;5326.733663316838;5752.165935939286;5826.737796799154;5846.298444186704;5872.412758724136;5880.794172203974;5882.2353094097925;5690.687012214326;5826.82519524415;5829.329627092875;5834.474897259267;5850.795222167225;5104.489551044903;5110.386753589593;5114.59083273341;5134.178531434953;5138.434772175057;19965.401037968884;20625.278115266043;21138.780428054986;21141.788582114135;21205.045772940255;2028.4320390290743;2071.0576687607104;2228.5988522066023;2345.9091522441977;2643.8810253538636;12842.229466232056;12973.481060757653;13337.33313334339;13367.264800435973;13698;1750.754894314797;1851.7407562941198;1871.5227616957725;1875.6248750249867;1892.7823300320501;56737.71631141818;58440.98708155006;58552.70723646397;59035;59919.70040149815;9388.389754665925;9404.95297523508;9489;9555.569999350046;9787.853182202272;13036;13063.934680326727;13065.934670326778;13066.281354525592;13071.019673524524;7297.671604777798;7612;7655.693772249159;7656;7899.170587088388;7776.066871975286;7777.805554861174;7807.531548107018;7880.605969701492;7884.21157884207;5797.2173756542325;5895.528357731457;5900.144479050514;5911.261092363455;5959;1626.2356692354574;1708.5728567858037;1743.5902562897709;1749.6763098826757;1776.4404212672966;875.65411662393;913.3697748553477;918.4198038595476;966.6520052780993;992.4095163377779;18044.18801153951;18344.633107337777;18757.155927983273;18859.622807543772;19061.714074288895;838.7106448275335;864.2999170671776;907.5915837872851;920.0891117793336;957.3298690916247;9713.854292185622;10179.338343007681;10239.897601023895;10276.486175691334;10291.33106348085;530889;532321;538466;539103;539197;80329;82200.58899705583;82240.58879705683;82403;82674.17325826664;1145.9312441253385;1150.2810743285447;1163.3310846263432;1168.2639936839737;1168.7019809948579;14941.551753447415;15802.76295855586;15918.204089795232;16070.839291607403;16415.9179204108;33794.66205338013;33867.49198761971;35077.824610876785;35085;37174.628253717114;41999.58000419957;43210;43222;43964;44528.55471445244;9777.755556111155;9877.06167914047;10090.69727908164;10095.848562271425;10103.747406314607;17719.734203986693;17978.820211798236;18008.819911800714;18524.907375463037;18549.90725046366;13259.469621215043;14340.21128837924;14546.92726536403;14547.78178327347;14554;14320.641983950485;14767.483138090116;14881.851181488046;14896.553103406915;15306.005109667836;11561.942190288995;11918.688944215955;14796.63008424798;15000.474983375529;15165.924170379078;8188.140245274399;9193.54032298369;9472.479013654316;9573.856392154263;9619.326647134634;9875.259355548218;9936.254780891317;13324.733505330032;13550.59348219555;13936.303184840515 04:04:00 INFO - PROCESS | 18879 | |3;mootools.html;1302.5506200360885;1457.4607395263752;1469.1258701072861;1620.8136064352602;1783.366904748815;6568.835779105525;7206.60363679998;7238.855222895546;7248.275172482749;7254.746083887065;7173.748918787844;7320.853582928352;7343;7363.337299643031;7383.40932725382;1914.15777058094;1965.2335589120255;1966.48871293464;2175.119076773909;2231.4532939429864;2013.6979453082008;2229.63211070174;2260.7513173550897;2275.7951784339407;2276.3057267533477;2257.5372048730055;2285.80570651494;2296.2537175417974;2296.977030229693;2306.2735238399932;2242.8990695418665;2257.8871056447274;2275.1581914691587;2275.82931280153;2276.2829708641725;2238.944026399337;2240.417491452234;2241.42843574889;2242.428180813882;2252.1329288223988;7298.489105762599;7396.186419493852;7397.223291554363;7397.556146631166;7411.85176296471;4548.931766023512;4645.558671926162;4647;4651.325557794101;4655.906881862377;2961.422522608092;3035.969640303591;3036.468617991865;3069.6162979627547;3070.7236348728497;903.7966457547066;912.5346073502495;920.1212841736193;926.6617684545092;950.4582388038821;9918.355306905029;9998.200143988464;10020.69937901864;10023.649172279009;10027.398356098585;4195.475565554306;4197.958020419818;4216.662666986634;4223.535411104776;4240.494624408352;8636.568171591396;8644.870326945102;8650.178233067849;8651.78370540729;8655.307575393954;4620.838270660511;4647.419072615923;4648.140094082605;4650.511696271843;4652.790624421909;4209.4948606166845;4254.042840360956;4256.36154576816;4261.424707664488;4270.957290427118;3304.8512816923294;3634.436662317345;3642.417213245868;3644.7813131211683;3687.631236876291;1126.4987080748988;1151.573917650458;1156.525824411987;1167.5154810753443;1170.1574866096396;1062.2882668612049;1063.6862125672944;1102.8841971593029;1229.8093795461718;1358.796180572922;6843.863122737617;6850.828729281808;6869.450443964471;6890.724371025203;6920.9653951729915;1105.7567335186245;1111.5109351885144;1117.983230251547;1140.0309736723718;1143.1312202725821;5550.972245138749;5615.129654903497;5641.802536911188;5646.661200327993;5650.3219613646625;8304.211099945496;8819.470831750115;8849.115088491099;8939.195472407515;8959.059298773534;8812.559372031374;8815.823683526294;8871.467711937305;8967.10328967098;9018.954905225432;6850.623215723183;6883.862322753617;6952.652367381611;7034.859302813915;7035.6482175891;6698.832529186614;6808.659567021728;6810;6815.522913396015;6826.624535650587;7587.250403075778;7794.727184548514;7903.1306556279915;7936.206379362017;7941;7865.095514015961;7979.680812767424;8038.276555110068;8088.797780055545;8108.594570271345;6437.25971513282;6438.7102580384935;6503.382178693017;6507.869842603216;6510.576812507172;6415.743370265137;6579.4736421085245;7135.8572828544175;7201.927980720336;7215.819604509929;6738.225104113089;6738.629375384205;6754.425873800782;6834;6859.211190712932;6680.899786503109;6689.397954184147;6703.095082163845;6793.422559082335;6811.046453496416;6676.732930682912;6681.09805176295;6724.899126513008;6727.831804204934;6737.157855268091;6072.757089716361;6091.177691011657;6107.694615269308;6176.598521096114;6183.227096612924;6252.406021427957;6269.843253918689;6345.143405640364;6352.936470635234;6361.427471527585 04:04:00 INFO - PROCESS | 18879 | |4;prototype.html;324.43386290922314;329.7955267734005;330.2503317469345;332.9683680050395;335.3444016946868;6057.303410107839;6087.512998960084;6088.05635126555;6115.2050233469645;6142.785002524907;5702.45826646469;5817.650940943536;5832.920909631721;5956;5958.404159584039;4593.586577208051;4615.053913947632;4621.722696638196;4624.3294722265255;4631.837885674002;4586.1974154522995;4614.492405835373;4614.515475875019;4620.838270660528;4646.117237724839;4398.868033958986;4442.644588432934;4476.753778542179;4544.2047641662575;4597.149527337437;4571.1771881061395;4581.312803079548;4584.908301833944;4590.6327493800745;4618.5381461853885;4027.597240275978;4032.737872038308;4041.1109555897656;4046.6560342370935;4049.088954985134;5756.913646295309;5758.193852860602;5775.191473193714;5783.363829978699;5786.68173250471;5162.457941916082;5388.541973932221;5397.136458166675;5399.136138217906;5400.459954004607;6391.328910464381;6396.552241343108;6403.551751377406;6405.263394709621;6410.326915673833;4415.514293427753;4416.40378548895;4420.182266280748;4424.247877860771;4426.800793964279;6465.935340646581;6618.933810661928;6639.1037209977;6660.23407308156;6718.932810671879;4468.195724769573;4474.910501789946;4477.19410506112;4483.932741008887;4489;4549.772511374485;4551.931721024187;4553.043860789205;4554.180247555471;4556.521565235669;5288.68267903927;5294.947050529522;5295.602829787781;5297.629165958423;5299.867503312448;6279.937200628026;6416.32628573993;6430.324815894357;6463;6474.223093228748;1585.7938467999086;1605.871530277575;1608.573727962091;1609.8470645288678;1610;1039.7660526381655;1060.0830281806182;1062.8033813744482;1080.783843231357;1084.35480888871;6053.697315134225;6058.333583305833;6064.272287325549;6064.818055458343;6067.059605761114;6643.5017373697165;6649.900251496231;6655.134832471747;6658.167729033871;6663.700133494004;5868.735906884201;5975.492083172979;6028.879422411527;6124.5712800103565;6130.386961303834;3602.081469225383;3614.475900994341;3625.873094441682;3627.528421305213;3629.201575653352;6746.898796518056;6755.054292399068;6755.527113102134;6760.661966901635;6762.594244345355;6744.932550674529;6898.103246577913;6901.62041087735;6905.965470172617;6908.412784913338;6738.022986666906;6754.45964322853;6764.458843292525;6766.594004359656;6770.661466926733;6709.161354830646;6715.127033485615;6715.194176698632;6715.865682686222;6721.495887808532;6454.870902581828;6629.171353580802;6674.432673222636;6676.265610782712;6688.966555167193;6774.627395493098;6777.695003724943;6778.559393639398;6781.593104413751;6784.59292442455;4525.321201819754;4572.268437050056;4572.81708731647;4574.565416285448;4575.794089266057;6515.804525864231;6704.631245281361;6707.195136583641;6764.729410823512;6772.5936443813525;6509.7396104155305;6535.281119076993;6537.80386588384;6540.901886471802;6543.1821022372205;6469.708863101077;6476.384743449365;6477.643729594917;6479.254885688206;6482.448991835747;6215.036669316263;6405.167328247484;6408.487321014401;6408.647524386203;6417.518686098655;6548.869022619616;6554.213494380705;6555.147830782159;6562.671866406756;6567.638779866962;6236.314005459305;6399.584027038228;6408.903866441914;6410.391012853772;6412.679366031586 04:04:00 INFO - PROCESS | 18879 | |5;yui.html;734.2107234722673;768.8654485465044;799.8480288745138;844.1136806353328;863.8833757442743;13497.730045399087;13835.515756948509;13850.792238116424;13859.168449893014;13865.93067034666;12805.295708736016;12888.097833151684;12900.483980640787;12904.419301131447;14667.486637967673;827.3050637464544;835.1272919798795;836.8117173635914;837.4305472278847;839.0728245288959;832.1803024021334;834.3575446905879;835.6072645856437;837.1168417319725;837.8952630921135;872.5070335260589;873.3275377958968;874.7813046738315;875.8642410426362;876.0582373948031;876.7676565710092;880.2913654508119;880.3353468131584;881.4534988307258;881.9118088191161;640.186962557554;646.3988490703643;647.9028145778124;648.1282674802384;648.4455790299273;12880.227186368847;12883.227006379553;12975.286359250238;13009.154404963647;13023.609291721263;10620.681379558626;11699.064074874075;12029.157958942878;12596.181248218836;12781.360931953364;10253.179745620408;10352.482375881176;10401.531931063044;10577.36535807854;10671.092957098655;3429.588449386065;3537.3102245062223;3614.421692529209;3624.2932628137523;3642.36258654737;41922.580774192174;42018.949526261786;46304.768476157406;46374.07251854978;48246.758766206294;9983.500824958723;9998.200143988464;10024.54889529973;10139.188864890939;10139.64511242103;17789.377371791925;17824.46526604204;17845.553861153316;17846;17848.286068557372;7567;7574.280443357872;7600.657970391346;7854.175311592315;7932.841343173104;4348.891277718082;4406.889827754332;4407.493138289074;4413.293872980308;4414.558544145624;3069.969300307013;3142.5443310720275;3145.6382516010494;3146.6853314668806;3149.27566659665;547.9972600136974;553.3498139685853;558.5726918907039;559.1808001278147;559.5942941367557;539.9514043736083;625.9843503912439;649.8342922554718;652.6769249221571;672.1832972937904;8514.829703406022;8795.780105497413;8834.116588341114;8953.731388058368;9193.77015574616;640.6252342379667;645.4352441613588;645.5706954874955;660.3792435111076;686.8042607856737;3883.3204189266767;4052.392141178788;4057.188562287495;4098.631123198927;4173.144505376391;53892;54327.18509222365;54966.450335496935;55571.166432503545;55624;49353.50646493489;49734.25398619023;49766.751166243936;49767.50232497629;50225.49774502281;41318;45957.310640339754;47662.76168619135;48120.27819582709;48740.26889596659;8438.282745966417;8438.409311348147;8533.573321333784;8546.829063418572;8707.3034157266;33449.832750837064;34416.65583344134;35097.947061588195;35699.28601427905;37161.442578361886;39326.41010384904;39484.802575986934;40174;40564.1887162261;41520.58479415288;10770.784584308427;11030.669079927615;11141.832872506757;11207.106170756713;11340.659780206606;12356.443960021641;12585;12684;12739.681507962376;12785.16896401731;11804.586839460577;11895.167338286583;12139.635810925687;12182.695432614255;12397.070219733376;11699.122565807429;11786;11834.349110798988;11855.347955862166;11954.701132471759;11452.3701196435;11642.068634509049;11909.583164589198;12019.399030048287;12030.578929737418;9680.612775489184;9807.705768826947;9876.555554999899;9930.702078937644;10100.595976161165;9484.288678349014;9793.85561903249;9933;10028.548715307683;10350.844737329096 04:04:00 INFO - PROCESS | 18879 | __end_tp_report 04:04:00 INFO - PROCESS | 18879 | __start_cc_report 04:04:00 INFO - PROCESS | 18879 | _x_x_mozilla_cycle_collect,848 04:04:00 INFO - PROCESS | 18879 | __end_cc_report 04:04:00 INFO - PROCESS | 18879 | __startTimestamp1451477040901__endTimestamp 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | ------- Summary: start ------- 04:04:00 INFO - PROCESS | 18879 | Number of tests: 6 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#0] dojo.html Cycles:165 Average:5359.33 Median:5517.83 stddev:586.83 (10.6%) stddev-sans-first:562.68 04:04:00 INFO - PROCESS | 18879 | Values: 3159.4 3202.8 3236.3 3237.9 3259.9 5195.4 5317.4 5416.1 5449.4 5501.6 5266.8 5384.3 5386.1 5417.3 5484.9 4927.2 4948.4 4952.7 4959.0 4979.9 5010.5 5047.2 5094.0 5120.0 5130.3 4767.1 4804.7 4916.0 4921.3 4945.6 4943.5 4944.2 4949.0 4952.8 4996.3 4810.1 4901.7 4930.8 4944.3 4969.2 5183.5 5189.6 5273.1 5301.8 5304.8 5760.2 5796.7 5798.6 5799.7 5803.4 5810.7 5840.8 5842.5 5842.8 5843.7 5305.3 5376.1 5406.8 5413.9 5489.6 5952.7 5956.9 5964.6 6010.1 6017.6 5693.3 5742.9 5744.5 5746.4 5750.9 5694.7 5802.4 5808.5 5888.7 5901.4 5725.5 5731.3 5736.1 5751.2 5768.7 5732.7 5734.2 5744.2 5751.3 5755.1 4373.1 4427.8 4430.3 4434.9 4460.2 3920.1 3938.1 4002.5 4026.0 4041.4 5343.0 5354.5 5356.7 5359.3 5360.6 5631.7 5727.5 5797.9 5802.9 5804.5 5230.8 5308.6 5339.9 5373.3 5414.3 5023.1 5048.2 5050.5 5054.3 5098.0 5726.3 5790.0 5927.5 5939.6 5949.8 5660.8 5723.2 5775.2 5780.1 5832.7 5908.6 5916.0 5916.3 5916.5 5924.1 5635.7 5746.3 5767.7 5783.4 5788.6 5780.5 5853.3 5857.3 5869.7 5870.6 5540.2 5630.2 5642.8 5646.4 5648.7 5573.1 5602.3 5630.3 5635.2 5640.3 5417.1 5503.4 5517.8 5596.3 5632.8 5542.0 5560.6 5565.8 5574.5 5596.8 5393.2 5431.6 5434.3 5437.1 5452.2 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#1] ext.html Cycles:180 Average:46154.01 Median:332906.00 stddev:78845.68 (23.7%) stddev-sans-first:78992.47 04:04:00 INFO - PROCESS | 18879 | Values: 537.9 538.9 544.0 560.7 575.8 28657.1 29293.7 35392.8 36003.0 36134.8 39489.8 39649.0 39748.0 39800.0 39858.0 7384.1 8255.4 8408.4 8416.5 8419.8 7406.9 9984.6 10189.4 10195.7 10205.1 9861.4 9912.5 9959.9 9961.6 9966.2 7492.0 7653.0 9871.1 9972.3 10011.3 9695.1 9819.8 9825.8 9827.8 9828.7 36297.5 36923.6 36969.4 36983.4 37054.3 3113.3 3151.6 3202.0 3212.9 3249.6 28199.4 30590.7 30806.7 30825.5 30956.0 3848.1 3849.8 3873.2 3906.2 3975.8 267716.0 270252.0 271440.0 271564.0 271966.0 52470.0 52594.5 52596.2 52690.0 55738.0 49063.5 62455.0 63244.0 63353.0 63481.4 15339.5 15689.7 15732.4 15738.2 15740.5 11366.9 11528.8 12056.7 12327.6 12382.4 18371.9 18493.5 18499.4 18525.2 18572.6 7171.7 7475.8 7505.8 7604.2 7644.4 887.1 980.6 1052.2 1061.5 1085.3 28377.3 28521.3 28532.6 28565.3 28898.3 954.0 1051.8 1094.0 1123.9 1125.9 15127.2 15273.8 15608.5 16148.8 16241.2 327252.0 332683.0 333129.0 333304.0 333357.0 51963.2 52866.0 53073.7 53092.5 53149.7 1373.5 1380.6 1398.5 1399.2 1402.8 27968.7 29039.4 29064.7 29355.7 29492.0 44864.6 45008.5 45296.0 45342.3 45358.8 296029.0 298775.0 298831.0 298955.0 299293.0 28818.6 30701.2 30979.5 31276.7 31557.7 36783.6 37625.4 37862.6 38457.2 38458.8 30392.2 32604.7 34949.0 36318.0 36723.0 29707.0 34266.3 34436.3 35419.3 35869.6 32784.5 32982.2 33249.7 35819.6 36562.8 27834.6 28751.7 29627.0 30821.2 31249.5 23989.8 24009.8 24238.9 24308.0 24388.5 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#2] jquery.html Cycles:180 Average:28828.97 Median:357.85 stddev:87535.72 (24461.5%) stddev-sans-first:87755.17 04:04:00 INFO - PROCESS | 18879 | Values: 355.0 357.2 358.5 362.8 364.6 14047.2 14226.1 16296.7 16559.4 17252.0 15524.5 16091.7 16283.5 16654.2 16671.8 5251.4 5359.5 5375.6 5387.9 5395.9 3993.6 4088.9 5273.6 5326.7 5752.2 5826.7 5846.3 5872.4 5880.8 5882.2 5690.7 5826.8 5829.3 5834.5 5850.8 5104.5 5110.4 5114.6 5134.2 5138.4 19965.4 20625.3 21138.8 21141.8 21205.0 2028.4 2071.1 2228.6 2345.9 2643.9 12842.2 12973.5 13337.3 13367.3 13698.0 1750.8 1851.7 1871.5 1875.6 1892.8 56737.7 58441.0 58552.7 59035.0 59919.7 9388.4 9405.0 9489.0 9555.6 9787.9 13036.0 13063.9 13065.9 13066.3 13071.0 7297.7 7612.0 7655.7 7656.0 7899.2 7776.1 7777.8 7807.5 7880.6 7884.2 5797.2 5895.5 5900.1 5911.3 5959.0 1626.2 1708.6 1743.6 1749.7 1776.4 875.7 913.4 918.4 966.7 992.4 18044.2 18344.6 18757.2 18859.6 19061.7 838.7 864.3 907.6 920.1 957.3 9713.9 10179.3 10239.9 10276.5 10291.3 530889.0 532321.0 538466.0 539103.0 539197.0 80329.0 82200.6 82240.6 82403.0 82674.2 1145.9 1150.3 1163.3 1168.3 1168.7 14941.6 15802.8 15918.2 16070.8 16415.9 33794.7 33867.5 35077.8 35085.0 37174.6 41999.6 43210.0 43222.0 43964.0 44528.6 9777.8 9877.1 10090.7 10095.8 10103.7 17719.7 17978.8 18008.8 18524.9 18549.9 13259.5 14340.2 14546.9 14547.8 14554.0 14320.6 14767.5 14881.9 14896.6 15306.0 11561.9 11918.7 14796.6 15000.5 15165.9 8188.1 9193.5 9472.5 9573.9 9619.3 9875.3 9936.3 13324.7 13550.6 13936.3 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#3] mootools.html Cycles:180 Average:5210.39 Median:6349.04 stddev:2628.91 (41.4%) stddev-sans-first:2619.87 04:04:00 INFO - PROCESS | 18879 | Values: 1302.6 1457.5 1469.1 1620.8 1783.4 6568.8 7206.6 7238.9 7248.3 7254.7 7173.7 7320.9 7343.0 7363.3 7383.4 1914.2 1965.2 1966.5 2175.1 2231.5 2013.7 2229.6 2260.8 2275.8 2276.3 2257.5 2285.8 2296.3 2297.0 2306.3 2242.9 2257.9 2275.2 2275.8 2276.3 2238.9 2240.4 2241.4 2242.4 2252.1 7298.5 7396.2 7397.2 7397.6 7411.9 4548.9 4645.6 4647.0 4651.3 4655.9 2961.4 3036.0 3036.5 3069.6 3070.7 903.8 912.5 920.1 926.7 950.5 9918.4 9998.2 10020.7 10023.6 10027.4 4195.5 4198.0 4216.7 4223.5 4240.5 8636.6 8644.9 8650.2 8651.8 8655.3 4620.8 4647.4 4648.1 4650.5 4652.8 4209.5 4254.0 4256.4 4261.4 4271.0 3304.9 3634.4 3642.4 3644.8 3687.6 1126.5 1151.6 1156.5 1167.5 1170.2 1062.3 1063.7 1102.9 1229.8 1358.8 6843.9 6850.8 6869.5 6890.7 6921.0 1105.8 1111.5 1118.0 1140.0 1143.1 5551.0 5615.1 5641.8 5646.7 5650.3 8304.2 8819.5 8849.1 8939.2 8959.1 8812.6 8815.8 8871.5 8967.1 9019.0 6850.6 6883.9 6952.7 7034.9 7035.6 6698.8 6808.7 6810.0 6815.5 6826.6 7587.3 7794.7 7903.1 7936.2 7941.0 7865.1 7979.7 8038.3 8088.8 8108.6 6437.3 6438.7 6503.4 6507.9 6510.6 6415.7 6579.5 7135.9 7201.9 7215.8 6738.2 6738.6 6754.4 6834.0 6859.2 6680.9 6689.4 6703.1 6793.4 6811.0 6676.7 6681.1 6724.9 6727.8 6737.2 6072.8 6091.2 6107.7 6176.6 6183.2 6252.4 6269.8 6345.1 6352.9 6361.4 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#4] prototype.html Cycles:180 Average:5362.44 Median:6061.30 stddev:1628.78 (26.9%) stddev-sans-first:1588.84 04:04:00 INFO - PROCESS | 18879 | Values: 324.4 329.8 330.3 333.0 335.3 6057.3 6087.5 6088.1 6115.2 6142.8 5702.5 5817.7 5832.9 5956.0 5958.4 4593.6 4615.1 4621.7 4624.3 4631.8 4586.2 4614.5 4614.5 4620.8 4646.1 4398.9 4442.6 4476.8 4544.2 4597.1 4571.2 4581.3 4584.9 4590.6 4618.5 4027.6 4032.7 4041.1 4046.7 4049.1 5756.9 5758.2 5775.2 5783.4 5786.7 5162.5 5388.5 5397.1 5399.1 5400.5 6391.3 6396.6 6403.6 6405.3 6410.3 4415.5 4416.4 4420.2 4424.2 4426.8 6465.9 6618.9 6639.1 6660.2 6718.9 4468.2 4474.9 4477.2 4483.9 4489.0 4549.8 4551.9 4553.0 4554.2 4556.5 5288.7 5294.9 5295.6 5297.6 5299.9 6279.9 6416.3 6430.3 6463.0 6474.2 1585.8 1605.9 1608.6 1609.8 1610.0 1039.8 1060.1 1062.8 1080.8 1084.4 6053.7 6058.3 6064.3 6064.8 6067.1 6643.5 6649.9 6655.1 6658.2 6663.7 5868.7 5975.5 6028.9 6124.6 6130.4 3602.1 3614.5 3625.9 3627.5 3629.2 6746.9 6755.1 6755.5 6760.7 6762.6 6744.9 6898.1 6901.6 6906.0 6908.4 6738.0 6754.5 6764.5 6766.6 6770.7 6709.2 6715.1 6715.2 6715.9 6721.5 6454.9 6629.2 6674.4 6676.3 6689.0 6774.6 6777.7 6778.6 6781.6 6784.6 4525.3 4572.3 4572.8 4574.6 4575.8 6515.8 6704.6 6707.2 6764.7 6772.6 6509.7 6535.3 6537.8 6540.9 6543.2 6469.7 6476.4 6477.6 6479.3 6482.4 6215.0 6405.2 6408.5 6408.6 6417.5 6548.9 6554.2 6555.1 6562.7 6567.6 6236.3 6399.6 6408.9 6410.4 6412.7 04:04:00 INFO - PROCESS | 18879 | 04:04:00 INFO - PROCESS | 18879 | [#5] yui.html Cycles:180 Average:13550.54 Median:4407.19 stddev:15229.81 (345.6%) stddev-sans-first:15242.12 04:04:00 INFO - PROCESS | 18879 | Values: 734.2 768.9 799.8 844.1 863.9 13497.7 13835.5 13850.8 13859.2 13865.9 12805.3 12888.1 12900.5 12904.4 14667.5 827.3 835.1 836.8 837.4 839.1 832.2 834.4 835.6 837.1 837.9 872.5 873.3 874.8 875.9 876.1 876.8 880.3 880.3 881.5 881.9 640.2 646.4 647.9 648.1 648.4 12880.2 12883.2 12975.3 13009.2 13023.6 10620.7 11699.1 12029.2 12596.2 12781.4 10253.2 10352.5 10401.5 10577.4 10671.1 3429.6 3537.3 3614.4 3624.3 3642.4 41922.6 42018.9 46304.8 46374.1 48246.8 9983.5 9998.2 10024.5 10139.2 10139.6 17789.4 17824.5 17845.6 17846.0 17848.3 7567.0 7574.3 7600.7 7854.2 7932.8 4348.9 4406.9 4407.5 4413.3 4414.6 3070.0 3142.5 3145.6 3146.7 3149.3 548.0 553.3 558.6 559.2 559.6 540.0 626.0 649.8 652.7 672.2 8514.8 8795.8 8834.1 8953.7 9193.8 640.6 645.4 645.6 660.4 686.8 3883.3 4052.4 4057.2 4098.6 4173.1 53892.0 54327.2 54966.5 55571.2 55624.0 49353.5 49734.3 49766.8 49767.5 50225.5 41318.0 45957.3 47662.8 48120.3 48740.3 8438.3 8438.4 8533.6 8546.8 8707.3 33449.8 34416.7 35097.9 35699.3 37161.4 39326.4 39484.8 40174.0 40564.2 41520.6 10770.8 11030.7 11141.8 11207.1 11340.7 12356.4 12585.0 12684.0 12739.7 12785.2 11804.6 11895.2 12139.6 12182.7 12397.1 11699.1 11786.0 11834.3 11855.3 11954.7 11452.4 11642.1 11909.6 12019.4 12030.6 9680.6 9807.7 9876.6 9930.7 10100.6 9484.3 9793.9 9933.0 10028.5 10350.8 04:04:00 INFO - PROCESS | 18879 | -------- Summary: end -------- 04:04:00 INFO - PROCESS | 18879 | 04:04:01 INFO - TEST-INFO | 18879: exit 0 04:04:01 INFO - TEST-OK | dromaeo_css | took 1113451ms 04:04:01 INFO - TEST-START | kraken 04:04:01 INFO - operating with platform_type : linux_ 04:04:01 INFO - Initialising browser for kraken test... 04:04:01 INFO - TEST-INFO | started process 19063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT9PZY8/profile http://localhost:46165/getInfo.html) 04:04:05 INFO - PROCESS | 19063 | __metrics Screen width/height:1600/1200 04:04:05 INFO - PROCESS | 19063 | colorDepth:24 04:04:05 INFO - PROCESS | 19063 | Browser inner width/height: 1024/697 04:04:05 INFO - PROCESS | 19063 | __metrics 04:04:05 INFO - PROCESS | 19063 | 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:04:05 INFO - PROCESS | 19063 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:04:06 INFO - TEST-INFO | 19063: exit 0 04:04:06 INFO - Browser initialized. 04:04:06 INFO - Running cycle 1/1 for kraken test... 04:04:06 INFO - TEST-INFO | started process 19145 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpT9PZY8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:18 INFO - PROCESS | 19145 | RSS: Main: 149336064 04:04:18 INFO - PROCESS | 19145 | 04:04:20 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46165/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:21 INFO - PROCESS | 19145 | RSS: Main: 185503744 04:04:21 INFO - PROCESS | 19145 | 04:04:24 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46165/tests/kraken/driver.html?testName=audio-dft) 04:04:24 INFO - PROCESS | 19145 | RSS: Main: 172761088 04:04:24 INFO - PROCESS | 19145 | 04:04:27 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46165/tests/kraken/driver.html?testName=audio-fft) 04:04:28 INFO - PROCESS | 19145 | RSS: Main: 160419840 04:04:28 INFO - PROCESS | 19145 | 04:04:30 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46165/tests/kraken/driver.html?testName=audio-oscillator) 04:04:30 INFO - PROCESS | 19145 | RSS: Main: 163700736 04:04:30 INFO - PROCESS | 19145 | 04:04:32 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:33 INFO - PROCESS | 19145 | RSS: Main: 164306944 04:04:33 INFO - PROCESS | 19145 | 04:04:36 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46165/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:36 INFO - PROCESS | 19145 | RSS: Main: 165117952 04:04:36 INFO - PROCESS | 19145 | 04:04:40 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46165/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:40 INFO - PROCESS | 19145 | RSS: Main: 165695488 04:04:40 INFO - PROCESS | 19145 | 04:04:43 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46165/tests/kraken/driver.html?testName=json-parse-financial) 04:04:44 INFO - PROCESS | 19145 | RSS: Main: 164392960 04:04:44 INFO - PROCESS | 19145 | 04:04:45 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:04:46 INFO - PROCESS | 19145 | RSS: Main: 176803840 04:04:46 INFO - PROCESS | 19145 | 04:04:48 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:04:48 INFO - PROCESS | 19145 | RSS: Main: 174948352 04:04:48 INFO - PROCESS | 19145 | 04:04:50 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:04:51 INFO - PROCESS | 19145 | RSS: Main: 186679296 04:04:51 INFO - PROCESS | 19145 | 04:04:53 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:04:54 INFO - PROCESS | 19145 | RSS: Main: 197382144 04:04:54 INFO - PROCESS | 19145 | 04:04:56 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:04:57 INFO - PROCESS | 19145 | RSS: Main: 193249280 04:04:57 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | Cycle 1(1): loaded http://localhost:46165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46165/tests/kraken/driver.html?testName=ai-astar) 04:04:59 INFO - PROCESS | 19145 | RSS: Main: 251289600 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | __start_tp_report 04:04:59 INFO - PROCESS | 19145 | _x_x_mozilla_page_load 04:04:59 INFO - PROCESS | 19145 | _x_x_mozilla_page_load_details 04:04:59 INFO - PROCESS | 19145 | |i|pagename|runs| 04:04:59 INFO - PROCESS | 19145 | |0;ai-astar;108;110;103;111;108;111;99;110;109;102 04:04:59 INFO - PROCESS | 19145 | |1;audio-beat-detection;151;135;154;167;128;150;151;127;167;129 04:04:59 INFO - PROCESS | 19145 | |2;audio-dft;163;160;159;159;160;163;159;160;159;161 04:04:59 INFO - PROCESS | 19145 | |3;audio-fft;73;71;83;94;75;75;72;127;90;72 04:04:59 INFO - PROCESS | 19145 | |4;audio-oscillator;96;95;150;96;95;95;140;95;96;148 04:04:59 INFO - PROCESS | 19145 | |5;imaging-gaussian-blur;109;109;109;109;108;109;109;110;109;109 04:04:59 INFO - PROCESS | 19145 | |6;imaging-darkroom;146;145;145;145;145;146;145;146;145;145 04:04:59 INFO - PROCESS | 19145 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 04:04:59 INFO - PROCESS | 19145 | |8;json-parse-financial;60;56;56;65;58;57;56;67;55;56 04:04:59 INFO - PROCESS | 19145 | |9;json-stringify-tinderbox;67;67;67;66;67;67;67;75;67;68 04:04:59 INFO - PROCESS | 19145 | |10;stanford-crypto-aes;87;85;88;86;84;86;87;88;87;89 04:04:59 INFO - PROCESS | 19145 | |11;stanford-crypto-ccm;115;119;118;115;124;118;124;124;120;115 04:04:59 INFO - PROCESS | 19145 | |12;stanford-crypto-pbkdf2;142;155;151;154;163;149;154;151;157;142 04:04:59 INFO - PROCESS | 19145 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;69;69;68;67;67 04:04:59 INFO - PROCESS | 19145 | __end_tp_report 04:04:59 INFO - PROCESS | 19145 | __start_cc_report 04:04:59 INFO - PROCESS | 19145 | _x_x_mozilla_cycle_collect,929 04:04:59 INFO - PROCESS | 19145 | __end_cc_report 04:04:59 INFO - PROCESS | 19145 | __startTimestamp1451477099423__endTimestamp 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | ------- Summary: start ------- 04:04:59 INFO - PROCESS | 19145 | Number of tests: 14 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#0] ai-astar Cycles:10 Average:107.10 Median:110.00 stddev:4.23 (3.8%) stddev-sans-first:4.47 04:04:59 INFO - PROCESS | 19145 | Values: 108.0 110.0 103.0 111.0 108.0 111.0 99.0 110.0 109.0 102.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:151.00 stddev:15.30 (10.1%) stddev-sans-first:16.12 04:04:59 INFO - PROCESS | 19145 | Values: 151.0 135.0 154.0 167.0 128.0 150.0 151.0 127.0 167.0 129.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.57 (1.0%) stddev-sans-first:1.32 04:04:59 INFO - PROCESS | 19145 | Values: 163.0 160.0 159.0 159.0 160.0 163.0 159.0 160.0 159.0 161.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:17.38 (23.2%) stddev-sans-first:18.04 04:04:59 INFO - PROCESS | 19145 | Values: 73.0 71.0 83.0 94.0 75.0 75.0 72.0 127.0 90.0 72.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:95.00 stddev:24.56 (25.9%) stddev-sans-first:25.47 04:04:59 INFO - PROCESS | 19145 | Values: 96.0 95.0 150.0 96.0 95.0 95.0 140.0 95.0 96.0 148.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 04:04:59 INFO - PROCESS | 19145 | Values: 109.0 109.0 109.0 109.0 108.0 109.0 109.0 110.0 109.0 109.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:04:59 INFO - PROCESS | 19145 | Values: 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:04:59 INFO - PROCESS | 19145 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:4.17 (7.2%) stddev-sans-first:4.39 04:04:59 INFO - PROCESS | 19145 | Values: 60.0 56.0 56.0 65.0 58.0 57.0 56.0 67.0 55.0 56.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.00 stddev:2.57 (3.8%) stddev-sans-first:2.71 04:04:59 INFO - PROCESS | 19145 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 67.0 75.0 67.0 68.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 04:04:59 INFO - PROCESS | 19145 | Values: 87.0 85.0 88.0 86.0 84.0 86.0 87.0 88.0 87.0 89.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:119.50 stddev:3.74 (3.1%) stddev-sans-first:3.64 04:04:59 INFO - PROCESS | 19145 | Values: 115.0 119.0 118.0 115.0 124.0 118.0 124.0 124.0 120.0 115.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:154.00 stddev:6.44 (4.2%) stddev-sans-first:5.78 04:04:59 INFO - PROCESS | 19145 | Values: 142.0 155.0 151.0 154.0 163.0 149.0 154.0 151.0 157.0 142.0 04:04:59 INFO - PROCESS | 19145 | 04:04:59 INFO - PROCESS | 19145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 04:04:59 INFO - PROCESS | 19145 | Values: 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 67.0 67.0 04:04:59 INFO - PROCESS | 19145 | -------- Summary: end -------- 04:04:59 INFO - PROCESS | 19145 | 04:05:00 INFO - TEST-INFO | 19145: exit 0 04:05:00 INFO - TEST-OK | kraken | took 58675ms 04:05:00 INFO - TEST-START | v8_7 04:05:00 INFO - operating with platform_type : linux_ 04:05:00 INFO - Initialising browser for v8_7 test... 04:05:00 INFO - TEST-INFO | started process 19396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9suhK4/profile http://localhost:46165/getInfo.html) 04:05:04 INFO - PROCESS | 19396 | __metrics Screen width/height:1600/1200 04:05:04 INFO - PROCESS | 19396 | colorDepth:24 04:05:04 INFO - PROCESS | 19396 | Browser inner width/height: 1024/697 04:05:04 INFO - PROCESS | 19396 | __metrics 04:05:04 INFO - PROCESS | 19396 | 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:05:04 INFO - PROCESS | 19396 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:05 INFO - TEST-INFO | 19396: exit 0 04:05:05 INFO - Browser initialized. 04:05:05 INFO - Running cycle 1/1 for v8_7 test... 04:05:05 INFO - TEST-INFO | started process 19478 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9suhK4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:16 INFO - PROCESS | 19478 | RSS: Main: 149725184 04:05:16 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | Cycle 1(1): loaded http://localhost:46165/tests/v8_7/run.html (next: http://localhost:46165/tests/v8_7/run.html) 04:05:38 INFO - PROCESS | 19478 | RSS: Main: 611602432 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | __start_tp_report 04:05:38 INFO - PROCESS | 19478 | _x_x_mozilla_page_load 04:05:38 INFO - PROCESS | 19478 | _x_x_mozilla_page_load_details 04:05:38 INFO - PROCESS | 19478 | |i|pagename|runs| 04:05:38 INFO - PROCESS | 19478 | |0;Richards;166.08536787908986 04:05:38 INFO - PROCESS | 19478 | |1;DeltaBlue;191.71779141104295 04:05:38 INFO - PROCESS | 19478 | |2;Encrypt;279.87685418415896 04:05:38 INFO - PROCESS | 19478 | |3;Decrypt;5284.210526315789 04:05:38 INFO - PROCESS | 19478 | |4;RayTrace;1113.4593993325918 04:05:38 INFO - PROCESS | 19478 | |5;Earley;793.0214115781126 04:05:38 INFO - PROCESS | 19478 | |6;Boyer;12268.292682926829 04:05:38 INFO - PROCESS | 19478 | |7;RegExp;25666.666666666668 04:05:38 INFO - PROCESS | 19478 | |8;Splay;571.7552887364208 04:05:38 INFO - PROCESS | 19478 | |9;NavierStokes;4822.115384615385 04:05:38 INFO - PROCESS | 19478 | __end_tp_report 04:05:38 INFO - PROCESS | 19478 | __startTimestamp1451477138463__endTimestamp 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | ------- Summary: start ------- 04:05:38 INFO - PROCESS | 19478 | Number of tests: 10 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 166.1 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#1] DeltaBlue Cycles:1 Average:191.72 Median:191.72 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 191.7 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 279.9 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#3] Decrypt Cycles:1 Average:5284.21 Median:5284.21 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 5284.2 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#4] RayTrace Cycles:1 Average:1113.46 Median:1113.46 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 1113.5 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 793.0 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 12268.3 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 25666.7 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#8] Splay Cycles:1 Average:571.76 Median:571.76 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 571.8 04:05:38 INFO - PROCESS | 19478 | 04:05:38 INFO - PROCESS | 19478 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:05:38 INFO - PROCESS | 19478 | Values: 4822.1 04:05:38 INFO - PROCESS | 19478 | -------- Summary: end -------- 04:05:38 INFO - PROCESS | 19478 | 04:05:39 INFO - TEST-INFO | 19478: exit 0 04:05:39 INFO - TEST-OK | v8_7 | took 38978ms 04:05:39 INFO - SUITE-END | took 1211s 04:05:39 INFO - Completed test suite (00:20:11) 04:05:39 INFO - Working with test: dromaeo_css 04:05:39 INFO - Generating results file: dromaeo_css 04:05:39 INFO - Working with test: kraken 04:05:39 INFO - Generating results file: kraken 04:05:39 INFO - javascript benchmark 04:05:39 INFO - Working with test: v8_7 04:05:39 INFO - Generating results file: v8_7 04:05:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:05:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:05:39 INFO - process_Request line: dromaeo_css 6978.49 graph.html#tests=[[72,63,35]] 04:05:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:05:39 INFO - process_Request line: kraken 1509.20 graph.html#tests=[[232,63,35]] 04:05:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:05:39 INFO - process_Request line: v8_7 21072.38 graph.html#tests=[[230,63,35]] 04:05:39 INFO - RETURN: dromaeo_css: 6978.49 04:05:39 INFO - RETURN: kraken: 1509.20 04:05:39 INFO - RETURN: v8_7: 21072.38 04:05:39 INFO - javascript benchmark 04:05:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3159.352332771782, 3202.823844688541, 3236.2880166363393, 3237.854296556655, 3259.934801303974, 5195.428502864682, 5317.441668624797, 5416.052190866598, 5449.373322067959, 5501.587380946425, 5266.841994740154, 5384.326959130109, 5386.057439948013, 5417.26866872972, 5484.862878428041, 4927.187014142671, 4948.406191257036, 4952.727599981999, 4959.008198360342, 4979.875503112415, 5010.498950104979, 5047.192449208127, 5094.0, 5120.02719483297, 5130.2817605535065, 4767.094252092092, 4804.687695299812, 4916.0, 4921.335619691332, 4945.629077819178, 4943.456219815817, 4944.233643785183, 4948.975255123702, 4952.777125029383, 4996.325496058022, 4810.11012962603, 4901.6964722563125, 4930.778114984834, 4944.258361245806, 4969.155243608595, 5183.481651834786, 5189.636725429222, 5273.050850846846, 5301.761420736076, 5304.761285742113, 5760.164776107441, 5796.681182534959, 5798.594098413113, 5799.710014499258, 5803.361630220672, 5810.6513609183585, 5840.795572154997, 5842.503387212049, 5842.824715258549, 5843.707814609253, 5305.283786688786, 5376.139817629239, 5406.783728650849, 5413.918791218135, 5489.615726899079, 5952.672603006789, 5956.940430595725, 5964.642121472725, 6010.128531362928, 6017.608855424383, 5693.28833895763, 5742.856428589319, 5744.482996530249, 5746.367899531048, 5750.913736293959, 5694.658320500783, 5802.448767367094, 5808.5062769665055, 5888.705564721832, 5901.380355062743, 5725.484706376446, 5731.254936858182, 5736.110902810071, 5751.194832723422, 5768.653880767168, 5732.656040637575, 5734.2258795062135, 5744.224529688438, 5751.252337196138, 5755.1367294906095, 4373.059792144704, 4427.75647339393, 4430.335449682509, 4434.911301773946, 4460.174867649495, 3920.1179734559496, 3938.0942383252013, 4002.45966794479, 4026.013626661487, 4041.413994970713, 5343.038253114477, 5354.4645535446925, 5356.651817631841, 5359.3032905722, 5360.597955153379, 5631.662100273915, 5727.455891690282, 5797.942020579824, 5802.854928626733, 5804.535637149018, 5230.8169214077325, 5308.575313974873, 5339.893202135935, 5373.274607927958, 5414.269073675082, 5023.095842748267, 5048.192289233705, 5050.4697006814495, 5054.292399064134, 5098.031374038921, 5726.341470730836, 5790.0, 5927.525797936155, 5939.584229103922, 5949.762009519657, 5660.773569057192, 5723.198752174616, 5775.191473193672, 5780.075187969905, 5832.650040997553, 5908.645481270965, 5915.994280972331, 5916.26046744157, 5916.497097746567, 5924.052151655715, 5635.718214089197, 5746.339170995389, 5767.653940763567, 5783.363829978614, 5788.594798364074, 5780.450857168562, 5853.2976042875125, 5857.297124345106, 5869.706514674334, 5870.559708022, 5540.196671482693, 5630.211770352236, 5642.830715078554, 5646.435356464321, 5648.745806438638, 5573.108302671553, 5602.299712535933, 5630.296212973379, 5635.211070450058, 5640.294963129609, 5417.133258678593, 5503.394626591152, 5517.834464966058, 5596.300462442195, 5632.7746890123935, 5542.0, 5560.5829562783765, 5565.777368905198, 5574.526165275997, 5596.804111856066, 5393.217983392307, 5431.565474762088, 5434.2935418395355, 5437.13005919051, 5452.154915988028], "unit": "score", "name": "dojo.html", "value": 5321.616001261042}, {"lowerIsBetter": false, "replicates": [537.9166229234469, 538.8625900395399, 544.0261931143253, 560.6608002158692, 575.8387651457591, 28657.140285791433, 29293.707062929363, 35392.823035884816, 36003.0, 36134.819325903336, 39489.802550987275, 39649.0, 39748.0, 39800.0, 39858.0, 7384.076990376203, 8255.380846436527, 8408.369372297071, 8416.495010299372, 8419.83160336793, 7406.8888966665545, 9984.550695218697, 10189.439580823051, 10195.745106372364, 10205.132563732055, 9861.359011664219, 9912.504374781269, 9959.850602240973, 9961.551730172123, 9966.202703783716, 7492.0, 7653.0, 9871.062249086326, 9972.252081093911, 10011.299209055369, 9695.127438530566, 9819.803603927881, 9825.803483930282, 9827.77152855893, 9828.655997040141, 36297.45553816695, 36923.63076369229, 36969.44545831814, 36983.445248321295, 37054.258914821825, 3113.315070684446, 3151.6060492438446, 3202.039388183559, 3212.9114580218134, 3249.5938007749032, 28199.43601127966, 30590.694093059006, 30806.691933080605, 30825.537616935762, 30956.0, 3848.0956975110826, 3849.826757795906, 3873.205992771503, 3906.160175562239, 3975.840966361342, 267716.0, 270252.0, 271440.0, 271563.999999998, 271966.0, 52470.0, 52594.47405525972, 52596.21105683418, 52690.0, 55738.0, 49063.50936490661, 62455.0, 63244.0, 63353.0, 63481.365186347546, 15339.539813805604, 15689.68620627604, 15732.449364272195, 15738.213089345487, 15740.527784166494, 11366.886331136582, 11528.769424611628, 12056.698582535331, 12327.568535101229, 12382.442790074469, 18371.90814045921, 18493.53766155857, 18499.445016649523, 18525.166367513495, 18572.628547428976, 7171.748988785367, 7475.813104672318, 7505.812354691067, 7604.201558836353, 7644.388448924073, 887.1217494680349, 980.5685498380832, 1052.2108418685987, 1061.5117046158698, 1085.3433672628105, 28377.29056773597, 28521.286967825556, 28532.572011419845, 28565.28586785347, 28898.27754306159, 954.022127319503, 1051.805415998043, 1094.0372472224392, 1123.915706322029, 1125.8536390269212, 15127.243637818285, 15273.770893436607, 15608.531744047697, 16148.838511614733, 16241.187940603158, 327252.0, 332683.0, 333129.0, 333304.0, 333357.0, 51963.22055169175, 52866.0, 53073.734631326595, 53092.46907530875, 53149.7342513285, 1373.4506197520873, 1380.5513208207374, 1398.4755716606273, 1399.2024546008881, 1402.8036074949516, 27968.720312796613, 29039.41921161607, 29064.709352907044, 29355.706442935298, 29492.0, 44864.55135448735, 45008.549914500436, 45296.0, 45342.31986520139, 45358.77320613376, 296029.0, 298775.0, 298831.0, 298955.0, 299293.0, 28818.567721484615, 30701.23246918845, 30979.535306969963, 31276.687233127377, 31557.684423155475, 36783.63216367802, 37625.4356184652, 37862.62137378591, 38457.23085538329, 38458.80770596129, 30392.240193995327, 32604.673953260164, 34949.0, 36318.0, 36723.0, 29707.0, 34266.31467370688, 34436.31127377489, 35419.29161416809, 35869.641303587676, 32784.50823237606, 32982.175445614055, 33249.66750332466, 35819.64180358163, 36562.817185914966, 27834.5824812632, 28751.712482874904, 29627.0, 30821.22946926345, 31249.531257031616, 23989.76010239875, 24009.759902400754, 24238.87880560586, 24308.0, 24388.51222975495], "unit": "score", "name": "ext.html", "value": 18216.292071355627}, {"lowerIsBetter": false, "replicates": [354.9538559987203, 357.20165430263376, 358.4998926497536, 362.7696412777886, 364.5898364340117, 14047.157170569773, 14226.146431214134, 16296.696264298856, 16559.420420285292, 17252.0, 15524.534263972071, 16091.678166436664, 16283.51149465515, 16654.1672916354, 16671.83328166718, 5251.422343542217, 5359.464053594648, 5375.569954403658, 5387.892242155154, 5395.892082158354, 3993.620606042436, 4088.8568900088503, 5273.57811375091, 5326.733663316838, 5752.165935939286, 5826.737796799154, 5846.298444186704, 5872.412758724136, 5880.794172203974, 5882.2353094097925, 5690.687012214326, 5826.82519524415, 5829.329627092875, 5834.474897259267, 5850.795222167225, 5104.489551044903, 5110.386753589593, 5114.59083273341, 5134.178531434953, 5138.434772175057, 19965.401037968884, 20625.278115266043, 21138.780428054986, 21141.788582114135, 21205.045772940255, 2028.4320390290743, 2071.0576687607104, 2228.5988522066023, 2345.9091522441977, 2643.8810253538636, 12842.229466232056, 12973.481060757653, 13337.33313334339, 13367.264800435973, 13698.0, 1750.754894314797, 1851.7407562941198, 1871.5227616957725, 1875.6248750249867, 1892.7823300320501, 56737.71631141818, 58440.98708155006, 58552.70723646397, 59035.0, 59919.70040149815, 9388.389754665925, 9404.95297523508, 9489.0, 9555.569999350046, 9787.853182202272, 13036.0, 13063.934680326727, 13065.934670326778, 13066.281354525592, 13071.019673524524, 7297.671604777798, 7612.0, 7655.693772249159, 7656.0, 7899.170587088388, 7776.066871975286, 7777.805554861174, 7807.531548107018, 7880.605969701492, 7884.21157884207, 5797.2173756542325, 5895.528357731457, 5900.144479050514, 5911.261092363455, 5959.0, 1626.2356692354574, 1708.5728567858037, 1743.5902562897709, 1749.6763098826757, 1776.4404212672966, 875.65411662393, 913.3697748553477, 918.4198038595476, 966.6520052780993, 992.4095163377779, 18044.18801153951, 18344.633107337777, 18757.155927983273, 18859.622807543772, 19061.714074288895, 838.7106448275335, 864.2999170671776, 907.5915837872851, 920.0891117793336, 957.3298690916247, 9713.854292185622, 10179.338343007681, 10239.897601023895, 10276.486175691334, 10291.33106348085, 530889.0, 532321.0, 538466.0, 539103.0, 539197.0, 80329.0, 82200.58899705583, 82240.58879705683, 82403.0, 82674.17325826664, 1145.9312441253385, 1150.2810743285447, 1163.3310846263432, 1168.2639936839737, 1168.7019809948579, 14941.551753447415, 15802.76295855586, 15918.204089795232, 16070.839291607403, 16415.9179204108, 33794.66205338013, 33867.49198761971, 35077.824610876785, 35085.0, 37174.628253717114, 41999.58000419957, 43210.0, 43222.0, 43964.0, 44528.55471445244, 9777.755556111155, 9877.06167914047, 10090.69727908164, 10095.848562271425, 10103.747406314607, 17719.734203986693, 17978.820211798236, 18008.819911800714, 18524.907375463037, 18549.90725046366, 13259.469621215043, 14340.21128837924, 14546.92726536403, 14547.78178327347, 14554.0, 14320.641983950485, 14767.483138090116, 14881.851181488046, 14896.553103406915, 15306.005109667836, 11561.942190288995, 11918.688944215955, 14796.63008424798, 15000.474983375529, 15165.924170379078, 8188.140245274399, 9193.54032298369, 9472.479013654316, 9573.856392154263, 9619.326647134634, 9875.259355548218, 9936.254780891317, 13324.733505330032, 13550.59348219555, 13936.303184840515], "unit": "score", "name": "jquery.html", "value": 9018.113077460826}, {"lowerIsBetter": false, "replicates": [1302.5506200360885, 1457.4607395263752, 1469.1258701072861, 1620.8136064352602, 1783.366904748815, 6568.835779105525, 7206.60363679998, 7238.855222895546, 7248.275172482749, 7254.746083887065, 7173.748918787844, 7320.853582928352, 7343.0, 7363.337299643031, 7383.40932725382, 1914.15777058094, 1965.2335589120255, 1966.48871293464, 2175.119076773909, 2231.4532939429864, 2013.6979453082008, 2229.63211070174, 2260.7513173550897, 2275.7951784339407, 2276.3057267533477, 2257.5372048730055, 2285.80570651494, 2296.2537175417974, 2296.977030229693, 2306.2735238399932, 2242.8990695418665, 2257.8871056447274, 2275.1581914691587, 2275.82931280153, 2276.2829708641725, 2238.944026399337, 2240.417491452234, 2241.42843574889, 2242.428180813882, 2252.1329288223988, 7298.489105762599, 7396.186419493852, 7397.223291554363, 7397.556146631166, 7411.85176296471, 4548.931766023512, 4645.558671926162, 4647.0, 4651.325557794101, 4655.906881862377, 2961.422522608092, 3035.969640303591, 3036.468617991865, 3069.6162979627547, 3070.7236348728497, 903.7966457547066, 912.5346073502495, 920.1212841736193, 926.6617684545092, 950.4582388038821, 9918.355306905029, 9998.200143988464, 10020.69937901864, 10023.649172279009, 10027.398356098585, 4195.475565554306, 4197.958020419818, 4216.662666986634, 4223.535411104776, 4240.494624408352, 8636.568171591396, 8644.870326945102, 8650.178233067849, 8651.78370540729, 8655.307575393954, 4620.838270660511, 4647.419072615923, 4648.140094082605, 4650.511696271843, 4652.790624421909, 4209.4948606166845, 4254.042840360956, 4256.36154576816, 4261.424707664488, 4270.957290427118, 3304.8512816923294, 3634.436662317345, 3642.417213245868, 3644.7813131211683, 3687.631236876291, 1126.4987080748988, 1151.573917650458, 1156.525824411987, 1167.5154810753443, 1170.1574866096396, 1062.2882668612049, 1063.6862125672944, 1102.8841971593029, 1229.8093795461718, 1358.796180572922, 6843.863122737617, 6850.828729281808, 6869.450443964471, 6890.724371025203, 6920.9653951729915, 1105.7567335186245, 1111.5109351885144, 1117.983230251547, 1140.0309736723718, 1143.1312202725821, 5550.972245138749, 5615.129654903497, 5641.802536911188, 5646.661200327993, 5650.3219613646625, 8304.211099945496, 8819.470831750115, 8849.115088491099, 8939.195472407515, 8959.059298773534, 8812.559372031374, 8815.823683526294, 8871.467711937305, 8967.10328967098, 9018.954905225432, 6850.623215723183, 6883.862322753617, 6952.652367381611, 7034.859302813915, 7035.6482175891, 6698.832529186614, 6808.659567021728, 6810.0, 6815.522913396015, 6826.624535650587, 7587.250403075778, 7794.727184548514, 7903.1306556279915, 7936.206379362017, 7941.0, 7865.095514015961, 7979.680812767424, 8038.276555110068, 8088.797780055545, 8108.594570271345, 6437.25971513282, 6438.7102580384935, 6503.382178693017, 6507.869842603216, 6510.576812507172, 6415.743370265137, 6579.4736421085245, 7135.8572828544175, 7201.927980720336, 7215.819604509929, 6738.225104113089, 6738.629375384205, 6754.425873800782, 6834.0, 6859.211190712932, 6680.899786503109, 6689.397954184147, 6703.095082163845, 6793.422559082335, 6811.046453496416, 6676.732930682912, 6681.09805176295, 6724.899126513008, 6727.831804204934, 6737.157855268091, 6072.757089716361, 6091.177691011657, 6107.694615269308, 6176.598521096114, 6183.227096612924, 6252.406021427957, 6269.843253918689, 6345.143405640364, 6352.936470635234, 6361.427471527585], "unit": "score", "name": "mootools.html", "value": 4318.024011960357}, {"lowerIsBetter": false, "replicates": [324.43386290922314, 329.7955267734005, 330.2503317469345, 332.9683680050395, 335.3444016946868, 6057.303410107839, 6087.512998960084, 6088.05635126555, 6115.2050233469645, 6142.785002524907, 5702.45826646469, 5817.650940943536, 5832.920909631721, 5956.0, 5958.404159584039, 4593.586577208051, 4615.053913947632, 4621.722696638196, 4624.3294722265255, 4631.837885674002, 4586.1974154522995, 4614.492405835373, 4614.515475875019, 4620.838270660528, 4646.117237724839, 4398.868033958986, 4442.644588432934, 4476.753778542179, 4544.2047641662575, 4597.149527337437, 4571.1771881061395, 4581.312803079548, 4584.908301833944, 4590.6327493800745, 4618.5381461853885, 4027.597240275978, 4032.737872038308, 4041.1109555897656, 4046.6560342370935, 4049.088954985134, 5756.913646295309, 5758.193852860602, 5775.191473193714, 5783.363829978699, 5786.68173250471, 5162.457941916082, 5388.541973932221, 5397.136458166675, 5399.136138217906, 5400.459954004607, 6391.328910464381, 6396.552241343108, 6403.551751377406, 6405.263394709621, 6410.326915673833, 4415.514293427753, 4416.40378548895, 4420.182266280748, 4424.247877860771, 4426.800793964279, 6465.935340646581, 6618.933810661928, 6639.1037209977, 6660.23407308156, 6718.932810671879, 4468.195724769573, 4474.910501789946, 4477.19410506112, 4483.932741008887, 4489.0, 4549.772511374485, 4551.931721024187, 4553.043860789205, 4554.180247555471, 4556.521565235669, 5288.68267903927, 5294.947050529522, 5295.602829787781, 5297.629165958423, 5299.867503312448, 6279.937200628026, 6416.32628573993, 6430.324815894357, 6463.0, 6474.223093228748, 1585.7938467999086, 1605.871530277575, 1608.573727962091, 1609.8470645288678, 1610.0, 1039.7660526381655, 1060.0830281806182, 1062.8033813744482, 1080.783843231357, 1084.35480888871, 6053.697315134225, 6058.333583305833, 6064.272287325549, 6064.818055458343, 6067.059605761114, 6643.5017373697165, 6649.900251496231, 6655.134832471747, 6658.167729033871, 6663.700133494004, 5868.735906884201, 5975.492083172979, 6028.879422411527, 6124.5712800103565, 6130.386961303834, 3602.081469225383, 3614.475900994341, 3625.873094441682, 3627.528421305213, 3629.201575653352, 6746.898796518056, 6755.054292399068, 6755.527113102134, 6760.661966901635, 6762.594244345355, 6744.932550674529, 6898.103246577913, 6901.62041087735, 6905.965470172617, 6908.412784913338, 6738.022986666906, 6754.45964322853, 6764.458843292525, 6766.594004359656, 6770.661466926733, 6709.161354830646, 6715.127033485615, 6715.194176698632, 6715.865682686222, 6721.495887808532, 6454.870902581828, 6629.171353580802, 6674.432673222636, 6676.265610782712, 6688.966555167193, 6774.627395493098, 6777.695003724943, 6778.559393639398, 6781.593104413751, 6784.59292442455, 4525.321201819754, 4572.268437050056, 4572.81708731647, 4574.565416285448, 4575.794089266057, 6515.804525864231, 6704.631245281361, 6707.195136583641, 6764.729410823512, 6772.5936443813525, 6509.7396104155305, 6535.281119076993, 6537.80386588384, 6540.901886471802, 6543.1821022372205, 6469.708863101077, 6476.384743449365, 6477.643729594917, 6479.254885688206, 6482.448991835747, 6215.036669316263, 6405.167328247484, 6408.487321014401, 6408.647524386203, 6417.518686098655, 6548.869022619616, 6554.213494380705, 6555.147830782159, 6562.671866406756, 6567.638779866962, 6236.314005459305, 6399.584027038228, 6408.903866441914, 6410.391012853772, 6412.679366031586], "unit": "score", "name": "prototype.html", "value": 4827.854372136221}, {"lowerIsBetter": false, "replicates": [734.2107234722673, 768.8654485465044, 799.8480288745138, 844.1136806353328, 863.8833757442743, 13497.730045399087, 13835.515756948509, 13850.792238116424, 13859.168449893014, 13865.93067034666, 12805.295708736016, 12888.097833151684, 12900.483980640787, 12904.419301131447, 14667.486637967673, 827.3050637464544, 835.1272919798795, 836.8117173635914, 837.4305472278847, 839.0728245288959, 832.1803024021334, 834.3575446905879, 835.6072645856437, 837.1168417319725, 837.8952630921135, 872.5070335260589, 873.3275377958968, 874.7813046738315, 875.8642410426362, 876.0582373948031, 876.7676565710092, 880.2913654508119, 880.3353468131584, 881.4534988307258, 881.9118088191161, 640.186962557554, 646.3988490703643, 647.9028145778124, 648.1282674802384, 648.4455790299273, 12880.227186368847, 12883.227006379553, 12975.286359250238, 13009.154404963647, 13023.609291721263, 10620.681379558626, 11699.064074874075, 12029.157958942878, 12596.181248218836, 12781.360931953364, 10253.179745620408, 10352.482375881176, 10401.531931063044, 10577.36535807854, 10671.092957098655, 3429.588449386065, 3537.3102245062223, 3614.421692529209, 3624.2932628137523, 3642.36258654737, 41922.580774192174, 42018.949526261786, 46304.768476157406, 46374.07251854978, 48246.758766206294, 9983.500824958723, 9998.200143988464, 10024.54889529973, 10139.188864890939, 10139.64511242103, 17789.377371791925, 17824.46526604204, 17845.553861153316, 17846.0, 17848.286068557372, 7567.0, 7574.280443357872, 7600.657970391346, 7854.175311592315, 7932.841343173104, 4348.891277718082, 4406.889827754332, 4407.493138289074, 4413.293872980308, 4414.558544145624, 3069.969300307013, 3142.5443310720275, 3145.6382516010494, 3146.6853314668806, 3149.27566659665, 547.9972600136974, 553.3498139685853, 558.5726918907039, 559.1808001278147, 559.5942941367557, 539.9514043736083, 625.9843503912439, 649.8342922554718, 652.6769249221571, 672.1832972937904, 8514.829703406022, 8795.780105497413, 8834.116588341114, 8953.731388058368, 9193.77015574616, 640.6252342379667, 645.4352441613588, 645.5706954874955, 660.3792435111076, 686.8042607856737, 3883.3204189266767, 4052.392141178788, 4057.188562287495, 4098.631123198927, 4173.144505376391, 53892.0, 54327.18509222365, 54966.450335496935, 55571.166432503545, 55624.0, 49353.50646493489, 49734.25398619023, 49766.751166243936, 49767.50232497629, 50225.49774502281, 41318.0, 45957.310640339754, 47662.76168619135, 48120.27819582709, 48740.26889596659, 8438.282745966417, 8438.409311348147, 8533.573321333784, 8546.829063418572, 8707.3034157266, 33449.832750837064, 34416.65583344134, 35097.947061588195, 35699.28601427905, 37161.442578361886, 39326.41010384904, 39484.802575986934, 40174.0, 40564.1887162261, 41520.58479415288, 10770.784584308427, 11030.669079927615, 11141.832872506757, 11207.106170756713, 11340.659780206606, 12356.443960021641, 12585.0, 12684.0, 12739.681507962376, 12785.16896401731, 11804.586839460577, 11895.167338286583, 12139.635810925687, 12182.695432614255, 12397.070219733376, 11699.122565807429, 11786.0, 11834.349110798988, 11855.347955862166, 11954.701132471759, 11452.3701196435, 11642.068634509049, 11909.583164589198, 12019.399030048287, 12030.578929737418, 9680.612775489184, 9807.705768826947, 9876.555554999899, 9930.702078937644, 10100.595976161165, 9484.288678349014, 9793.85561903249, 9933.0, 10028.548715307683, 10350.844737329096], "unit": "score", "name": "yui.html", "value": 6336.853378590341}], "name": "dromaeo_css", "value": 6978.496875766285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 111.0, 108.0, 111.0, 99.0, 110.0, 109.0, 102.0], "unit": "score", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [151.0, 135.0, 154.0, 167.0, 128.0, 150.0, 151.0, 127.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 159.0, 159.0, 160.0, 163.0, 159.0, 160.0, 159.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 83.0, 94.0, 75.0, 75.0, 72.0, 127.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 150.0, 96.0, 95.0, 95.0, 140.0, 95.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.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, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [60.0, 56.0, 56.0, 65.0, 58.0, 57.0, 56.0, 67.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 75.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 86.0, 84.0, 86.0, 87.0, 88.0, 87.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 118.0, 115.0, 124.0, 118.0, 124.0, 124.0, 120.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [142.0, 155.0, 151.0, 154.0, 163.0, 149.0, 154.0, 151.0, 157.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1509.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [191.71779141104295], "unit": "score", "name": "DeltaBlue", "value": 344.87148800000006}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5284.210526315789], "unit": "score", "name": "Decrypt", "value": 50.37289840637447}, {"lowerIsBetter": false, "replicates": [1113.4593993325918], "unit": "score", "name": "RayTrace", "value": 664.5855254745252}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [571.7552887364208], "unit": "score", "name": "Splay", "value": 142.52775899999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21072.37917109474}]} 04:05:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21072.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1509.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6978.49"}}} 04:05:39 INFO - Return code: 0 04:05:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:05:39 INFO - # TBPL SUCCESS # 04:05:39 INFO - Running post-action listener: _resource_record_post_action 04:05:39 INFO - Running post-run listener: _resource_record_post_run 04:05:40 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545132544; Read time: 12; Write time: 491484 04:05:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235433984; Read time: 0; Write time: 276976 04:05:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309698560; Read time: 12; Write time: 214508 04:05:40 INFO - Running post-run listener: _upload_blobber_files 04:05:40 INFO - Blob upload gear active. 04:05:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:05:40 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:05:40 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:05:40 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:05:41 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:42 INFO - (blobuploader) - INFO - Done attempting. 04:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:43 INFO - (blobuploader) - INFO - Done attempting. 04:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:43 INFO - Return code: 0 04:05:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d142a011f8a0e0670ec778183b230b2d4f7e9fff1fbbd1ec87db8cc4c0bbd911ef6e77bcdb793d98c3bd22398e88d68f31a3b6f781d602b489679543e90ded5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94385e876e5a4190be69019d7721cf5426f0f44cf4bb264e78628ff15e220f0586421432e4d6978646dda0b6c2b895a51ce3cee1811e79aa0a727e0bde5b6f48"} 04:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:05:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:05:43 INFO - Contents: 04:05:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d142a011f8a0e0670ec778183b230b2d4f7e9fff1fbbd1ec87db8cc4c0bbd911ef6e77bcdb793d98c3bd22398e88d68f31a3b6f781d602b489679543e90ded5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94385e876e5a4190be69019d7721cf5426f0f44cf4bb264e78628ff15e220f0586421432e4d6978646dda0b6c2b895a51ce3cee1811e79aa0a727e0bde5b6f48"} 04:05:43 INFO - Copying logs to upload dir... 04:05:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.175512 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-30 04:05:43.114923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 04:05:43.118528) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 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/d142a011f8a0e0670ec778183b230b2d4f7e9fff1fbbd1ec87db8cc4c0bbd911ef6e77bcdb793d98c3bd22398e88d68f31a3b6f781d602b489679543e90ded5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94385e876e5a4190be69019d7721cf5426f0f44cf4bb264e78628ff15e220f0586421432e4d6978646dda0b6c2b895a51ce3cee1811e79aa0a727e0bde5b6f48"} build_url:https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/EZCSH6q0Tt6b03fCvVHRhw/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/d142a011f8a0e0670ec778183b230b2d4f7e9fff1fbbd1ec87db8cc4c0bbd911ef6e77bcdb793d98c3bd22398e88d68f31a3b6f781d602b489679543e90ded5d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94385e876e5a4190be69019d7721cf5426f0f44cf4bb264e78628ff15e220f0586421432e4d6978646dda0b6c2b895a51ce3cee1811e79aa0a727e0bde5b6f48"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 04:05:43.143778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 04:05:43.144137) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a9e534cca236dfa67d42a089000001c1-1451475420.722309-382325431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 04:05:43.229598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 04:05:43.229996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 04:05:43.230358) ========= ========= Total master_lag: 0.28 =========