builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1452642409.81 results: success (0) buildid: 20160112133014 builduid: 9beb4669838845408b8f86c955937652 revision: d7cbb410ecd66c6bf5db94252d92ef5a34e93d14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.809573) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.810112) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.810475) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006371 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.834230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.834689) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.868057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.868355) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.918534) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.918812) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.919197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:49.919497) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 15:46:50-- 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% 30.5M=0s 2016-01-12 15:46:51 (30.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152084 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:50.084923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:50.085218) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:50.134151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 15:46:50.134500) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d7cbb410ecd66c6bf5db94252d92ef5a34e93d14 --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 d7cbb410ecd66c6bf5db94252d92ef5a34e93d14 --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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 15:46:51,144 truncating revision to first 12 chars 2016-01-12 15:46:51,144 Setting DEBUG logging. 2016-01-12 15:46:51,144 attempt 1/10 2016-01-12 15:46:51,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d7cbb410ecd6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 15:46:52,236 unpacking tar archive at: mozilla-inbound-d7cbb410ecd6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-12 15:46:51.546254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:51.546659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:51.555081) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:51.555342) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 15:46:51.555999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-12 15:46:51.556428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:46:52 INFO - MultiFileLogger online at 20160112 15:46:52 in /builds/slave/test-pgo 15:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:46:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:46:52 INFO - {'append_to_log': False, 15:46:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:46:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:46:52 INFO - 'branch': 'Mozilla-Inbound', 15:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:52 INFO - 'config_files': ('talos/linux_config.py',), 15:46:52 INFO - 'default_actions': ('clobber', 15:46:52 INFO - 'read-buildbot-config', 15:46:52 INFO - 'download-and-extract', 15:46:52 INFO - 'populate-webroot', 15:46:52 INFO - 'create-virtualenv', 15:46:52 INFO - 'install', 15:46:52 INFO - 'run-tests'), 15:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:52 INFO - 'download_minidump_stackwalk': True, 15:46:52 INFO - 'download_symbols': 'ondemand', 15:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:52 INFO - 'installer_path': 'installer.exe', 15:46:52 INFO - 'log_level': 'info', 15:46:52 INFO - 'log_name': 'talos', 15:46:52 INFO - 'log_to_console': True, 15:46:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:46:52 INFO - 'opt_config_files': (), 15:46:52 INFO - 'pip_index': False, 15:46:52 INFO - 'sps_profile': False, 15:46:52 INFO - 'sps_profile_interval': 0, 15:46:52 INFO - 'suite': 'dromaeojs-e10s', 15:46:52 INFO - 'system_bits': '32', 15:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:52 INFO - 'title': 'talos-linux64-ix-017', 15:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:52 INFO - 'use_talos_json': True, 15:46:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:52 INFO - 'work_dir': 'build'} 15:46:52 INFO - ##### 15:46:52 INFO - ##### Running clobber step. 15:46:52 INFO - ##### 15:46:52 INFO - Running pre-action listener: _resource_record_pre_action 15:46:52 INFO - Running main action method: clobber 15:46:52 INFO - rmtree: /builds/slave/test-pgo/build 15:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:46:53 INFO - Running post-action listener: _resource_record_post_action 15:46:53 INFO - ##### 15:46:53 INFO - ##### Running read-buildbot-config step. 15:46:53 INFO - ##### 15:46:53 INFO - Running pre-action listener: _resource_record_pre_action 15:46:53 INFO - Running main action method: read_buildbot_config 15:46:53 INFO - Using buildbot properties: 15:46:53 INFO - { 15:46:53 INFO - "project": "", 15:46:53 INFO - "product": "firefox", 15:46:53 INFO - "script_repo_revision": "production", 15:46:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:46:53 INFO - "repository": "", 15:46:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:46:53 INFO - "buildid": "20160112133014", 15:46:53 INFO - "pgo_build": "True", 15:46:53 INFO - "basedir": "/builds/slave/test-pgo", 15:46:53 INFO - "buildnumber": 246, 15:46:53 INFO - "slavename": "talos-linux64-ix-017", 15:46:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:46:53 INFO - "platform": "ubuntu64_hw", 15:46:53 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:46:53 INFO - "branch": "mozilla-inbound", 15:46:53 INFO - "repo_path": "integration/mozilla-inbound", 15:46:53 INFO - "revision": "d7cbb410ecd66c6bf5db94252d92ef5a34e93d14", 15:46:53 INFO - "stage_platform": "linux64-pgo", 15:46:53 INFO - "builduid": "9beb4669838845408b8f86c955937652", 15:46:53 INFO - "slavebuilddir": "test" 15:46:53 INFO - } 15:46:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:46:53 INFO - Running post-action listener: _resource_record_post_action 15:46:53 INFO - ##### 15:46:53 INFO - ##### Running download-and-extract step. 15:46:53 INFO - ##### 15:46:53 INFO - Running pre-action listener: _resource_record_pre_action 15:46:53 INFO - Running main action method: download_and_extract 15:46:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:46: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')]} 15:46:53 INFO - https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/test_packages.json 15:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/test_packages.json 15:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:46:55 INFO - Downloaded 1302 bytes. 15:46:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:46:55 INFO - Using the following test package requirements: 15:46:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:46:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'jsshell-linux-x86_64.zip'], 15:46:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:46:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:46:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:46:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:46:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:46:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:46: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')]} 15:46:55 INFO - https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:46:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:46:57 INFO - Downloaded 24029041 bytes. 15:46:57 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 15:46:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:57 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 15:46:58 INFO - Return code: 0 15:46:58 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 15:46: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')]} 15:46:58 INFO - https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:47:02 INFO - Downloaded 24029041 bytes. 15:47:02 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 15:47:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:47:02 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 15:47:04 INFO - Return code: 0 15:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:04 INFO - https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:47:06 INFO - Downloaded 11132279 bytes. 15:47:06 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 15:47:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:06 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 15:47:07 INFO - Return code: 0 15:47:07 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')]} 15:47:07 INFO - https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcQp3cB1TkWvO-zdcGI-xA/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 15:47:15 INFO - Downloaded 55898240 bytes. 15:47:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:15 INFO - mkdir: /builds/slave/test-pgo/properties 15:47:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:47:15 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:47:15 INFO - Contents: 15:47:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:47:15 INFO - Running post-action listener: _resource_record_post_action 15:47:15 INFO - Running post-action listener: set_extra_try_arguments 15:47:15 INFO - ##### 15:47:15 INFO - ##### Running populate-webroot step. 15:47:15 INFO - ##### 15:47:15 INFO - Running pre-action listener: _resource_record_pre_action 15:47:15 INFO - Running main action method: populate_webroot 15:47:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:15 INFO - '--tppagecycles', 15:47:15 INFO - '7'], 15:47:15 INFO - 'tests': ['tsvgm']}}, 15:47:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:47:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:47:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'tests': ['damp', 'tps']}, 15:47:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['damp', 'tps']}, 15:47:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:47:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:15 INFO - 'other': {'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'other_l64': {'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'other_nol64': {'tests': ['a11yr', 15:47:15 INFO - 'ts_paint', 15:47:15 INFO - 'tpaint', 15:47:15 INFO - 'sessionrestore', 15:47:15 INFO - 'sessionrestore_no_auto_restore']}, 15:47:15 INFO - 'svgr': {'tests': ['tsvgx', 15:47:15 INFO - 'tsvgr_opacity', 15:47:15 INFO - 'tart', 15:47:15 INFO - 'tscrollx', 15:47:15 INFO - 'cart']}, 15:47:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['tsvgx', 15:47:15 INFO - 'tsvgr_opacity', 15:47:15 INFO - 'tart', 15:47:15 INFO - 'tscrollx', 15:47:15 INFO - 'cart']}, 15:47:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'tests': ['tp5o']}, 15:47:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'talos_options': ['--e10s'], 15:47:15 INFO - 'tests': ['tp5o']}, 15:47:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'talos_options': ['--xperf_path', 15:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:15 INFO - 'tests': ['tp5n']}, 15:47:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:15 INFO - 'talos_options': ['--e10s', 15:47:15 INFO - '--xperf_path', 15:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:15 INFO - 'tests': ['tp5n']}}, 15:47:15 INFO - 'talos.zip': {'path': '', 15:47:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:15 INFO - Running post-action listener: _resource_record_post_action 15:47:15 INFO - ##### 15:47:15 INFO - ##### Running create-virtualenv step. 15:47:15 INFO - ##### 15:47:15 INFO - Running pre-action listener: _resource_record_pre_action 15:47:15 INFO - Running main action method: create_virtualenv 15:47:15 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:47:15 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 15:47:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:47:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:15 INFO - Using real prefix '/usr' 15:47:15 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:47:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:18 INFO - Installing pip.................done. 15:47:18 INFO - Return code: 0 15:47:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:47:18 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')]} 15:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:18 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')]} 15:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:18 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:18 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 15:47:18 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 15:47:18 INFO - Using env: {'DISPLAY': ':0', 15:47:18 INFO - 'HOME': '/home/cltbld', 15:47:18 INFO - 'LANG': 'en_US.UTF-8', 15:47:18 INFO - 'LANGUAGE': 'en_US:en', 15:47:18 INFO - 'LOGNAME': 'cltbld', 15:47:18 INFO - 'MAIL': '/var/mail/cltbld', 15:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:18 INFO - 'MOZ_NO_REMOTE': '1', 15:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:18 INFO - 'NO_EM_RESTART': '1', 15:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:18 INFO - 'SHELL': '/bin/bash', 15:47:18 INFO - 'SHLVL': '1', 15:47:18 INFO - 'TERM': 'linux', 15:47:18 INFO - 'TMOUT': '86400', 15:47:18 INFO - 'USER': 'cltbld', 15:47:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:18 INFO - '_': '/tools/buildbot/bin/python'} 15:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:18 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 15:47:18 INFO - Cleaning up... 15:47:18 INFO - Return code: 0 15:47:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:47:18 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')]} 15:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:18 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')]} 15:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:18 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:18 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 15:47:18 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 15:47:18 INFO - Using env: {'DISPLAY': ':0', 15:47:18 INFO - 'HOME': '/home/cltbld', 15:47:18 INFO - 'LANG': 'en_US.UTF-8', 15:47:18 INFO - 'LANGUAGE': 'en_US:en', 15:47:18 INFO - 'LOGNAME': 'cltbld', 15:47:18 INFO - 'MAIL': '/var/mail/cltbld', 15:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:18 INFO - 'MOZ_NO_REMOTE': '1', 15:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:18 INFO - 'NO_EM_RESTART': '1', 15:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:18 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:18 INFO - 'SHELL': '/bin/bash', 15:47:18 INFO - 'SHLVL': '1', 15:47:18 INFO - 'TERM': 'linux', 15:47:18 INFO - 'TMOUT': '86400', 15:47:18 INFO - 'USER': 'cltbld', 15:47:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:18 INFO - '_': '/tools/buildbot/bin/python'} 15:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:18 INFO - Downloading/unpacking psutil>=0.7.1 15:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:20 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:47:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:20 INFO - Installing collected packages: psutil 15:47:20 INFO - Running setup.py install for psutil 15:47:20 INFO - building 'psutil._psutil_linux' extension 15:47:20 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 15:47:20 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 15:47:20 INFO - building 'psutil._psutil_posix' extension 15:47:20 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 15:47:20 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 15:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:20 INFO - Successfully installed psutil 15:47:20 INFO - Cleaning up... 15:47:20 INFO - Return code: 0 15:47:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:20 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:20 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 15:47:20 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 15:47:20 INFO - Using env: {'DISPLAY': ':0', 15:47:20 INFO - 'HOME': '/home/cltbld', 15:47:20 INFO - 'LANG': 'en_US.UTF-8', 15:47:20 INFO - 'LANGUAGE': 'en_US:en', 15:47:20 INFO - 'LOGNAME': 'cltbld', 15:47:20 INFO - 'MAIL': '/var/mail/cltbld', 15:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:20 INFO - 'MOZ_NO_REMOTE': '1', 15:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:20 INFO - 'NO_EM_RESTART': '1', 15:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:20 INFO - 'SHELL': '/bin/bash', 15:47:20 INFO - 'SHLVL': '1', 15:47:20 INFO - 'TERM': 'linux', 15:47:20 INFO - 'TMOUT': '86400', 15:47:20 INFO - 'USER': 'cltbld', 15:47:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:20 INFO - '_': '/tools/buildbot/bin/python'} 15:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:47:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:47:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:47:22 INFO - Installing collected packages: mozsystemmonitor 15:47:22 INFO - Running setup.py install for mozsystemmonitor 15:47:22 INFO - Successfully installed mozsystemmonitor 15:47:22 INFO - Cleaning up... 15:47:22 INFO - Return code: 0 15:47:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:47:22 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')]} 15:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:22 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')]} 15:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:22 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:22 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 15:47:22 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 15:47:22 INFO - Using env: {'DISPLAY': ':0', 15:47:22 INFO - 'HOME': '/home/cltbld', 15:47:22 INFO - 'LANG': 'en_US.UTF-8', 15:47:22 INFO - 'LANGUAGE': 'en_US:en', 15:47:22 INFO - 'LOGNAME': 'cltbld', 15:47:22 INFO - 'MAIL': '/var/mail/cltbld', 15:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:22 INFO - 'MOZ_NO_REMOTE': '1', 15:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:22 INFO - 'NO_EM_RESTART': '1', 15:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:22 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:22 INFO - 'SHELL': '/bin/bash', 15:47:22 INFO - 'SHLVL': '1', 15:47:22 INFO - 'TERM': 'linux', 15:47:22 INFO - 'TMOUT': '86400', 15:47:22 INFO - 'USER': 'cltbld', 15:47:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:22 INFO - '_': '/tools/buildbot/bin/python'} 15:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:47:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:47:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:47:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:25 INFO - Downloading docopt-0.6.1.tar.gz 15:47:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:47:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:25 INFO - Running setup.py install for blobuploader 15:47:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:47:25 INFO - Running setup.py install for requests 15:47:26 INFO - Running setup.py install for docopt 15:47:26 INFO - Successfully installed blobuploader requests docopt 15:47:26 INFO - Cleaning up... 15:47:26 INFO - Return code: 0 15:47:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:26 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:26 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 15:47:26 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 15:47:26 INFO - Using env: {'DISPLAY': ':0', 15:47:26 INFO - 'HOME': '/home/cltbld', 15:47:26 INFO - 'LANG': 'en_US.UTF-8', 15:47:26 INFO - 'LANGUAGE': 'en_US:en', 15:47:26 INFO - 'LOGNAME': 'cltbld', 15:47:26 INFO - 'MAIL': '/var/mail/cltbld', 15:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:26 INFO - 'MOZ_NO_REMOTE': '1', 15:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:26 INFO - 'NO_EM_RESTART': '1', 15:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:26 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:26 INFO - 'SHELL': '/bin/bash', 15:47:26 INFO - 'SHLVL': '1', 15:47:26 INFO - 'TERM': 'linux', 15:47:26 INFO - 'TMOUT': '86400', 15:47:26 INFO - 'USER': 'cltbld', 15:47:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:26 INFO - '_': '/tools/buildbot/bin/python'} 15:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:26 INFO - Running setup.py (path:/tmp/pip-0fUO9u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:26 INFO - Running setup.py (path:/tmp/pip-51AD5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:26 INFO - Running setup.py (path:/tmp/pip-jsQJp7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:26 INFO - Running setup.py (path:/tmp/pip-I_FOzL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:26 INFO - Running setup.py (path:/tmp/pip-OXQL7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:26 INFO - Running setup.py (path:/tmp/pip-lmXNga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:26 INFO - Running setup.py (path:/tmp/pip-Jyvnmy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:26 INFO - Running setup.py (path:/tmp/pip-_HP51m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:27 INFO - Running setup.py (path:/tmp/pip-onxAz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:27 INFO - Running setup.py (path:/tmp/pip-joTKAQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:27 INFO - Running setup.py (path:/tmp/pip-K2wIKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:27 INFO - Running setup.py (path:/tmp/pip-5nrISr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:27 INFO - Running setup.py (path:/tmp/pip-eOxQ4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:27 INFO - Running setup.py (path:/tmp/pip-ezavFm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:27 INFO - Running setup.py (path:/tmp/pip-tjnB2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:27 INFO - Running setup.py (path:/tmp/pip-hRCl3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:27 INFO - Running setup.py (path:/tmp/pip-8ifNN4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:27 INFO - Running setup.py install for manifestparser 15:47:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:47:27 INFO - Running setup.py install for mozcrash 15:47:27 INFO - Running setup.py install for mozdebug 15:47:27 INFO - Running setup.py install for mozdevice 15:47:28 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for mozfile 15:47:28 INFO - Running setup.py install for mozhttpd 15:47:28 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for mozinfo 15:47:28 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for mozInstall 15:47:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for mozleak 15:47:28 INFO - Running setup.py install for mozlog 15:47:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for moznetwork 15:47:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:47:28 INFO - Running setup.py install for mozprocess 15:47:28 INFO - Running setup.py install for mozprofile 15:47:29 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:47:29 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:47:29 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:47:29 INFO - Running setup.py install for mozrunner 15:47:29 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:47:29 INFO - Running setup.py install for mozscreenshot 15:47:29 INFO - Running setup.py install for moztest 15:47:29 INFO - Running setup.py install for mozversion 15:47:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:47:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:29 INFO - Cleaning up... 15:47:29 INFO - Return code: 0 15:47:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:29 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')]} 15:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:29 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')]} 15:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:29 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:29 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 15:47:29 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 15:47:29 INFO - Using env: {'DISPLAY': ':0', 15:47:29 INFO - 'HOME': '/home/cltbld', 15:47:29 INFO - 'LANG': 'en_US.UTF-8', 15:47:29 INFO - 'LANGUAGE': 'en_US:en', 15:47:29 INFO - 'LOGNAME': 'cltbld', 15:47:29 INFO - 'MAIL': '/var/mail/cltbld', 15:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:29 INFO - 'MOZ_NO_REMOTE': '1', 15:47:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:29 INFO - 'NO_EM_RESTART': '1', 15:47:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:29 INFO - 'SHELL': '/bin/bash', 15:47:29 INFO - 'SHLVL': '1', 15:47:29 INFO - 'TERM': 'linux', 15:47:29 INFO - 'TMOUT': '86400', 15:47:29 INFO - 'USER': 'cltbld', 15:47:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:29 INFO - '_': '/tools/buildbot/bin/python'} 15:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:29 INFO - Running setup.py (path:/tmp/pip-TFSryY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:29 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)) 15:47:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:29 INFO - Running setup.py (path:/tmp/pip-EJojtj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:29 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)) 15:47:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:29 INFO - Running setup.py (path:/tmp/pip-iN7jhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:29 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)) 15:47:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:29 INFO - Running setup.py (path:/tmp/pip-g4EBAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:30 INFO - Running setup.py (path:/tmp/pip-Tv4Rqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:30 INFO - Running setup.py (path:/tmp/pip-LXVu3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:30 INFO - Running setup.py (path:/tmp/pip-fX7TbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:30 INFO - Running setup.py (path:/tmp/pip-N2gLqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:30 INFO - Running setup.py (path:/tmp/pip-t1ugWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:30 INFO - Running setup.py (path:/tmp/pip-tog2CQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:30 INFO - Running setup.py (path:/tmp/pip-_tnyDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:30 INFO - Running setup.py (path:/tmp/pip-lSsCh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:30 INFO - Running setup.py (path:/tmp/pip-Og2Dql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:30 INFO - Running setup.py (path:/tmp/pip-YcjQQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:30 INFO - Running setup.py (path:/tmp/pip-P0aP_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:30 INFO - Running setup.py (path:/tmp/pip-VKfcmQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:30 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)) 15:47:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:30 INFO - Running setup.py (path:/tmp/pip-wuAMKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:30 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)) 15:47:30 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)) 15:47:30 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)) 15:47:30 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)) 15:47:30 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:30 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:47:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:30 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 15:47:30 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 15:47:30 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 15:47:30 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 15:47:30 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 15:47:30 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 15:47:32 INFO - Downloading blessings-1.5.1.tar.gz 15:47:32 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 15:47:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:32 INFO - Installing collected packages: blessings 15:47:32 INFO - Running setup.py install for blessings 15:47:32 INFO - Successfully installed blessings 15:47:32 INFO - Cleaning up... 15:47:32 INFO - Return code: 0 15:47:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:47:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:33 INFO - Reading from file tmpfile_stdout 15:47:33 INFO - Current package versions: 15:47:33 INFO - argparse == 1.2.1 15:47:33 INFO - blessings == 1.5.1 15:47:33 INFO - blobuploader == 1.2.4 15:47:33 INFO - docopt == 0.6.1 15:47:33 INFO - manifestparser == 1.1 15:47:33 INFO - mozInstall == 1.12 15:47:33 INFO - mozcrash == 0.16 15:47:33 INFO - mozdebug == 0.1 15:47:33 INFO - mozdevice == 0.48 15:47:33 INFO - mozfile == 1.2 15:47:33 INFO - mozhttpd == 0.7 15:47:33 INFO - mozinfo == 0.9 15:47:33 INFO - mozleak == 0.1 15:47:33 INFO - mozlog == 3.1 15:47:33 INFO - moznetwork == 0.27 15:47:33 INFO - mozprocess == 0.22 15:47:33 INFO - mozprofile == 0.28 15:47:33 INFO - mozrunner == 6.11 15:47:33 INFO - mozscreenshot == 0.1 15:47:33 INFO - mozsystemmonitor == 0.0 15:47:33 INFO - moztest == 0.7 15:47:33 INFO - mozversion == 1.4 15:47:33 INFO - psutil == 3.1.1 15:47:33 INFO - requests == 1.2.3 15:47:33 INFO - wsgiref == 0.1.2 15:47:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:33 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')]} 15:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 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')]} 15:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:33 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 15:47:33 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 15:47:33 INFO - Using env: {'DISPLAY': ':0', 15:47:33 INFO - 'HOME': '/home/cltbld', 15:47:33 INFO - 'LANG': 'en_US.UTF-8', 15:47:33 INFO - 'LANGUAGE': 'en_US:en', 15:47:33 INFO - 'LOGNAME': 'cltbld', 15:47:33 INFO - 'MAIL': '/var/mail/cltbld', 15:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:33 INFO - 'MOZ_NO_REMOTE': '1', 15:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:33 INFO - 'NO_EM_RESTART': '1', 15:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:33 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:33 INFO - 'SHELL': '/bin/bash', 15:47:33 INFO - 'SHLVL': '1', 15:47:33 INFO - 'TERM': 'linux', 15:47:33 INFO - 'TMOUT': '86400', 15:47:33 INFO - 'USER': 'cltbld', 15:47:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:33 INFO - '_': '/tools/buildbot/bin/python'} 15:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 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)) 15:47:33 INFO - Cleaning up... 15:47:33 INFO - Return code: 0 15:47:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:47:33 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')]} 15:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 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')]} 15:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:33 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:33 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 15:47:33 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 15:47:33 INFO - Using env: {'DISPLAY': ':0', 15:47:33 INFO - 'HOME': '/home/cltbld', 15:47:33 INFO - 'LANG': 'en_US.UTF-8', 15:47:33 INFO - 'LANGUAGE': 'en_US:en', 15:47:33 INFO - 'LOGNAME': 'cltbld', 15:47:33 INFO - 'MAIL': '/var/mail/cltbld', 15:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:33 INFO - 'MOZ_NO_REMOTE': '1', 15:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:33 INFO - 'NO_EM_RESTART': '1', 15:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:33 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:33 INFO - 'SHELL': '/bin/bash', 15:47:33 INFO - 'SHLVL': '1', 15:47:33 INFO - 'TERM': 'linux', 15:47:33 INFO - 'TMOUT': '86400', 15:47:33 INFO - 'USER': 'cltbld', 15:47:33 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:33 INFO - '_': '/tools/buildbot/bin/python'} 15:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:33 INFO - Downloading/unpacking jsonschema 15:47:33 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 15:47:33 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 15:47:33 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 15:47:33 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 15:47:33 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 15:47:33 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 15:47:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:35 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 15:47:35 INFO - Downloading/unpacking functools32 (from jsonschema) 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:47:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Installing collected packages: jsonschema, functools32 15:47:35 INFO - Running setup.py install for functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Successfully installed jsonschema functools32 15:47:35 INFO - Cleaning up... 15:47:35 INFO - Return code: 0 15:47:35 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:47:35 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')]} 15:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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')]} 15:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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 0x7f9d6c09ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf3b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, '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': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', '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 15:47:35 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 15:47:35 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 15:47:35 INFO - Using env: {'DISPLAY': ':0', 15:47:35 INFO - 'HOME': '/home/cltbld', 15:47:35 INFO - 'LANG': 'en_US.UTF-8', 15:47:35 INFO - 'LANGUAGE': 'en_US:en', 15:47:35 INFO - 'LOGNAME': 'cltbld', 15:47:35 INFO - 'MAIL': '/var/mail/cltbld', 15:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:35 INFO - 'MOZ_NO_REMOTE': '1', 15:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:35 INFO - 'NO_EM_RESTART': '1', 15:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:35 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:35 INFO - 'SHELL': '/bin/bash', 15:47:35 INFO - 'SHLVL': '1', 15:47:35 INFO - 'TERM': 'linux', 15:47:35 INFO - 'TMOUT': '86400', 15:47:35 INFO - 'USER': 'cltbld', 15:47:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:35 INFO - '_': '/tools/buildbot/bin/python'} 15:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:35 INFO - Downloading/unpacking flake8 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:47:37 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 15:47:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:47:37 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 15:47:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:38 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 15:47:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:47:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:38 INFO - no previously-included directories found matching 'docs/_build' 15:47:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:47:38 INFO - Running setup.py install for pep8 15:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:47:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:47:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:47:38 INFO - no previously-included directories found matching 'docs/_build' 15:47:38 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:47:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:47:38 INFO - Cleaning up... 15:47:38 INFO - Return code: 0 15:47:38 INFO - Running post-action listener: _resource_record_post_action 15:47:38 INFO - Running post-action listener: _start_resource_monitoring 15:47:38 INFO - Starting resource monitoring. 15:47:38 INFO - ##### 15:47:38 INFO - ##### Running install step. 15:47:38 INFO - ##### 15:47:38 INFO - Running pre-action listener: _resource_record_pre_action 15:47:38 INFO - Running main action method: install 15:47:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:38 INFO - Reading from file tmpfile_stdout 15:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:47:38 INFO - Reading from file tmpfile_stdout 15:47:38 INFO - Output received: 15:47:38 INFO - Usage: mozinstall [options] installer 15:47:38 INFO - Options: 15:47:38 INFO - -h, --help show this help message and exit 15:47:38 INFO - -d DEST, --destination=DEST 15:47:38 INFO - Directory to install application into. [default: 15:47:38 INFO - "/builds/slave/test-pgo"] 15:47:38 INFO - --app=APP Application being installed. [default: firefox] 15:47:38 INFO - mkdir: /builds/slave/test-pgo/build/application 15:47:38 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'] 15:47:38 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 15:47:54 INFO - Reading from file tmpfile_stdout 15:47:54 INFO - Output received: 15:47:54 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:47:54 INFO - Running post-action listener: _resource_record_post_action 15:47:54 INFO - ##### 15:47:54 INFO - ##### Running run-tests step. 15:47:54 INFO - ##### 15:47:54 INFO - Running pre-action listener: _resource_record_pre_action 15:47:54 INFO - Running main action method: run_tests 15:47:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:47:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:47:54 INFO - Python 2.7.3 15:47:54 INFO - Return code: 0 15:47:54 INFO - grabbing minidump binary from tooltool 15:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:54 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 0x1097660>, '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 0x1098560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:47:54 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 15:47:54 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 15:47:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:47:55 INFO - Return code: 0 15:47:55 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:47:55 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:47:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:47:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:47:55 INFO - Return code: 0 15:47:55 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:47:55 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:47:55 INFO - Using env: {'DISPLAY': ':0', 15:47:55 INFO - 'HOME': '/home/cltbld', 15:47:55 INFO - 'LANG': 'en_US.UTF-8', 15:47:55 INFO - 'LANGUAGE': 'en_US:en', 15:47:55 INFO - 'LOGNAME': 'cltbld', 15:47:55 INFO - 'MAIL': '/var/mail/cltbld', 15:47:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:56 INFO - 'MOZ_NO_REMOTE': '1', 15:47:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:56 INFO - 'NO_EM_RESTART': '1', 15:47:56 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:56 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:47:56 INFO - 'SHELL': '/bin/bash', 15:47:56 INFO - 'SHLVL': '1', 15:47:56 INFO - 'TERM': 'linux', 15:47:56 INFO - 'TMOUT': '86400', 15:47:56 INFO - 'USER': 'cltbld', 15:47:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128', 15:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:56 INFO - '_': '/tools/buildbot/bin/python'} 15:47:56 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:47:56 INFO - mozversion application_buildid: 20160112133014 15:47:56 INFO - mozversion application_changeset: d7cbb410ecd66c6bf5db94252d92ef5a34e93d14 15:47:56 INFO - mozversion application_display_name: Nightly 15:47:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:47:56 INFO - mozversion application_name: Firefox 15:47:56 INFO - mozversion application_remotingname: firefox 15:47:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:47:56 INFO - mozversion application_vendor: Mozilla 15:47:56 INFO - mozversion application_version: 46.0a1 15:47:56 INFO - mozversion platform_buildid: 20160112133014 15:47:56 INFO - mozversion platform_changeset: d7cbb410ecd66c6bf5db94252d92ef5a34e93d14 15:47:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:47:56 INFO - mozversion platform_version: 46.0a1 15:47:56 INFO - using testdate: 1452642476 15:47:56 INFO - actual date: 1452642476 15:47:56 INFO - starting webserver on 'localhost:48939' 15:47:56 INFO - SUITE-START | Running 3 tests 15:47:56 INFO - TEST-START | dromaeo_css 15:47:56 INFO - operating with platform_type : linux_ 15:47:56 INFO - Initialising browser for dromaeo_css test... 15:47:56 INFO - TEST-INFO | started process 17282 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNaGQhl/profile http://localhost:48939/getInfo.html) 15:47:59 INFO - PROCESS | 17282 | 15:47:59 INFO - PROCESS | 17282 | (process:17367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:00 INFO - PROCESS | 17282 | __metrics Screen width/height:1600/1200 15:48:00 INFO - PROCESS | 17282 | colorDepth:24 15:48:00 INFO - PROCESS | 17282 | Browser inner width/height: 1024/697 15:48:00 INFO - PROCESS | 17282 | __metrics 15:48:00 INFO - PROCESS | 17282 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:48:01 INFO - TEST-INFO | 17282: exit 0 15:48:01 INFO - Browser initialized. 15:48:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:01 INFO - TEST-INFO | started process 17416 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNaGQhl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:02 INFO - PROCESS | 17416 | 15:48:02 INFO - PROCESS | 17416 | (process:17474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:48:13 INFO - PROCESS | 17416 | RSS: Main: 150659072 15:48:13 INFO - PROCESS | 17416 | 15:49:02 INFO - PROCESS | 17416 | 1452642542839 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] 15:51:11 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48939/tests/dromaeo/cssquery-ext.html) 15:51:12 INFO - PROCESS | 17416 | RSS: Main: 154923008 15:51:12 INFO - PROCESS | 17416 | 15:54:14 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-ext.html (next: http://localhost:48939/tests/dromaeo/cssquery-jquery.html) 15:54:15 INFO - PROCESS | 17416 | RSS: Main: 151011328 15:54:15 INFO - PROCESS | 17416 | 15:57:17 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48939/tests/dromaeo/cssquery-mootools.html) 15:57:17 INFO - PROCESS | 17416 | RSS: Main: 151580672 15:57:17 INFO - PROCESS | 17416 | 16:00:19 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48939/tests/dromaeo/cssquery-prototype.html) 16:00:19 INFO - PROCESS | 17416 | RSS: Main: 150360064 16:00:19 INFO - PROCESS | 17416 | 16:03:22 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48939/tests/dromaeo/cssquery-yui.html) 16:03:22 INFO - PROCESS | 17416 | RSS: Main: 150265856 16:03:22 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | Cycle 1(1): loaded http://localhost:48939/tests/dromaeo/cssquery-yui.html (next: http://localhost:48939/tests/dromaeo/cssquery-dojo.html) 16:06:25 INFO - PROCESS | 17416 | RSS: Main: 153346048 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | __start_tp_report 16:06:25 INFO - PROCESS | 17416 | _x_x_mozilla_page_load 16:06:25 INFO - PROCESS | 17416 | _x_x_mozilla_page_load_details 16:06:25 INFO - PROCESS | 17416 | |i|pagename|runs| 16:06:25 INFO - PROCESS | 17416 | |0;dojo.html;3217.8551965161564;3225.9354812903744;3270.6075270967485;3304.5869266341706;3306.5370848081257;5227.555657769094;5327.840164795052;5396.946030539693;5413.999999999995;5423.620346575736;5244.449332820056;5365.570754339653;5463.344398672155;5491.148871924848;5509.752061157247;4512.887177820564;4818.325434439173;4853.174960256765;4854.97572512137;4864.5378689024665;4776.4268287805335;4790.904181916359;4812.494688057756;4837.105135549917;4927.014597080581;4811.158047341702;4832.154372984731;4889.633277504166;4893.143699852511;4903.926441103386;4836.685615434985;4839.37088178538;4855.708657480563;4886.413630364379;4904.779284932187;4791.808327666924;4833.250846118857;4859.562639362474;4872;4879.194932836078;5267.420583735786;5324.5740340772645;5338.225957236218;5344.706041167734;5346.946530534684;5693.601447898649;5697.6011679182475;5703.0589952657765;5716.1711551825165;5720.942790572082;5669.206311116406;5720.885582288331;5721.914171287434;5765.538756899438;5794.391588883149;5384.542313903323;5405.648632838932;5435.103207970719;5442.455754424526;5498.285222920995;5829.708514574254;5837.9124313135335;5875.471207591252;5877.9999999999145;5889.146073819272;5602.635828671123;5636;5640.125780504029;5660.264165658438;5666.6600003999065;5806.912896306559;5808.332041815245;5812.215350927655;5817.912731309034;5848.2689663792025;5714.685692286964;5731.971340143273;5759.337676167294;5760.135979603009;5770.740316685759;5581.525570326487;5670.518005969457;5756.366799652035;5759.942400576025;5843.941560584425;4356.542563030836;4374.518802931675;4375.78121093944;4384.12317536494;4393.033532622818;3910.2961466936226;3933.62630550103;3955.426463162883;3971.205758848242;4001.239764444746;5276.841694749163;5316.893662126736;5348.171033489815;5369.731513424314;5423.05096608092;5711.228984087178;5714.457126573052;5744.741486633112;5745.85635359111;5773.826785196451;5302.125149350314;5389.245505629215;5409.459054094559;5413;5459.372172200168;4874.902501949941;4937.901241975141;4977.776000080005;4991.47589503097;5022.2466630005065;5887.175795388649;5890.175375447441;5900.76396944126;5902.2622172228475;5907.940920590825;5693.060644993529;5730.426957304237;5746.683932383759;5772.538196944319;5846.327672317738;5939.4951429129005;5980.252468441445;6006.978813601786;6007.189029480965;6056.606320589148;5719.084946408721;5720.542356611378;5725;5736.770529178953;5738.196652468741;5691.3170419549915;5749.942500574941;5760.971195143998;5822.76708931655;5831.562632802472;5700.657960522382;5712.600117991867;5724.284464441945;5735.827925162252;5775.162601422854;5598.440155984369;5624.803131890364;5626.578006649435;5630.493255607015;5646;5408.242846001484;5501.779928802963;5526.032944234823;5566.081596536526;5584.4136365681015;5702.059160238514;5702.486776190163;5736.225609542826;5755.597108202385;5759.740811663569;5601.131824567198;5612.943870561242;5614;5620.8875822482505;5621.775128994958 16:06:25 INFO - PROCESS | 17416 | |1;ext.html;536.1555550008735;541.3044238153973;544.727636181909;565.347024187064;602.9869818704577;28943.421131577383;36503.81748091259;36618.63381366192;36691.633083669156;36914;39661;39721.60278397215;40085;40131.79934100333;40168.79915600425;8361.958190209041;8573.399862009663;8615.267702245317;8624.784380390478;8692.217700406962;8452.070272270075;8561.571921403936;8570.700025499078;8580.35647326453;8582.656693732275;8484.19400156984;8583.484990900566;8604.48373097613;8605.913940860573;8609.483430994129;8572.785680357978;8712;8765.386422950396;8810.559472026373;8812.986506551764;8682.6092825823;8818.470891746516;8824.823503529959;8829.69096081634;8830.116988301119;40246.19507609861;40912.181756364706;40942.590574094174;40977.180456390706;41022.38466423006;3368.34317308125;3368.444206705891;3436.1753179237053;3598.4062629666337;3694.907627309312;29690.85154574235;30145.397092058036;30402.847985760152;30646.69353306461;31137.37725245505;3747.7001839852746;3819.4461803038403;3824.464574959508;3995.5604883462797;4105.712600117993;259841;261534;261891;262685;263174;52468;52879;57910.42089579134;60613.696931515944;61680.69159654263;55260.72369638126;55747;55781;55787.72106139525;55953;14274;14417.42330306776;14429.85570144306;14486.420543178365;14490.130592164292;10349.327293725884;10363.740906477398;10411.739706507398;10437.947810261052;10445.11216546587;20376.796232037785;20755.481112972295;20792.37622871316;20836.583268334853;20838.895805521177;7294.197638259787;7452.403807695371;7456.142543607554;7568.962155189189;7583.355414789805;872.1191596487594;916.2578311567652;960;998.1216529454034;1075.9515821788038;28692.13923582296;30774.692253077632;31208;31327.37345253082;31461.842690786856;1025.041586116983;1029.145808978546;1049.58541376156;1054.0829478353728;1095.4522738630685;14419.42322307117;14546.199959002144;14575.927120364331;14819.407223711147;14876.776848347283;326962;330207;330592;331467;332313;51903.48096519062;52035.73982130141;52094.21858672123;52154.21768673473;52227;1326.389860664086;1359.0079242153283;1365.7405093032291;1367.7264547090422;1372.7185926884965;27530;28413.431731365672;28443.28891777722;28508.714912851436;28668.569971450863;47166.52833471621;47182;47234.29148562843;47254;47266.76366618145;307943;309755;311176;311330;312702;32043.35913281768;32326;32705.34589308248;32792.67207327896;32958.17604559809;37796.43305350477;38060.80969595134;38210.80894595509;38275;38640;34547;35633.64366356407;35836.82081589576;35919.64080359163;36191.457128142574;34943.301133977686;35845.641543585276;36005.819970899975;36187.27625447529;36228.81885590555;34945.65054349424;35258.471122932664;35296;35393.82303088468;35511.28977420489;30611.2347191322;32242.193945151557;32330;32453.51319730159;32912.506312405814;24651;25025.374365641004;25036.874815625804;25100.372490687147;25497 16:06:25 INFO - PROCESS | 17416 | |2;jquery.html;364.16424306217215;367.3607922215346;367.4231456613117;370.36112705582866;370.86278077111467;15543;16546.91726541367;16887.24007419666;17376.739348909778;17486;15189.240537973084;15218;15706.764398534031;15742.449014284502;15777.21113944301;4897.314375987356;5096.2865198872005;5129.153689641204;5131.666441681297;5155.896882062375;5025.447200807908;5066.36670416198;5132.563732082777;5141.82003629873;5287.735613219324;5123.180291153398;5218.556422704075;5275.498827611371;5339.172428273624;5345.65253258537;5265.868353291179;5276.103062479368;5298.23175639532;5684.63049901755;6107.847303817396;5404.7838086476495;5425.267588875491;5433.0763770159165;5438.755256013489;5469.781208751645;15734.44929427476;19245;19791.703124453146;19870.105845236998;19880.304189353305;2039.694045893113;2074.4295318787304;2133.200049981257;2285.440067183534;2306.342692332694;10250.282480226388;12000.399980000964;12012.279263244145;12174.939125304405;12426.875731242662;1834.7706536682915;1855.8329750322537;1885.70771530413;1894.0624390926441;1918.4556432072177;53809.1928621071;54518.45481545213;55868.44131558673;56007;56099.439005610235;10211.387316761018;10233.181345492343;10263.794724105475;10303.587856485807;10352.792944141074;13318.933405333106;13413.86586134126;13433.19400835953;13442.126261792951;13467;6990.545614535039;7096.53872498286;7117.145942486831;7140.571565706075;7175.246599107123;6556.803295901131;6598.47212223021;6629.071929929813;6641.435477984329;6644.568103073285;4475.865724028285;4531.796069176895;4536.795844186953;4550.817967281338;4567.246404343313;1837.9724304135448;1893.4887580353227;1924.1052910396734;1965.8722183058342;1973.3685220729228;780.3289171312666;802.3781569283851;852.8038551133274;871.8866547348804;883.1301168349171;15227.61930951713;15495.380184792482;15759.68480630381;15815.841841581667;15826.76259856103;934.3412893909913;950.458238803889;952.476138124029;997.2420960070399;1018.8675472188568;9383.859242111374;9433.245340372754;9548.092931171666;9613.951930240444;9818.65634702782;459333;467401;469852;482956.3408731806;520434;72093.63953180201;72727.63636181786;73854;74354;75459.62270188614;1099.6481126039591;1120.7198200449889;1137.7212582917239;1146.5012719467059;1147.6327575175865;14128.717425651635;14931.626709332353;14953.700925981637;15148.545543633709;15326.310316036028;32340.35319293648;32806.30241828863;32917;34271.828640856635;34482.482762758074;37800.81099594595;38999.805000975946;39138;39446.2110757789;39830.402543962446;7105.8578828422105;7155.570665760071;7197.388222001188;7312.232215617496;7493.43799215072;9771.31600787938;9773.75565610837;10705.464726763475;11025.44872756343;11074.280171788809;9437.056294370508;9481.715548533555;9576.090271424204;9653.227741780782;9878.110970012733;8760;9005.459672419676;9257.398269112486;9653.613855445703;9943.453110078726;9367.203787678123;9649.517524123907;9907.554160062959;10072.546735396778;10305.896941030795;7549;7571.621418929141;7620.8475830484185;7670.348020418327;7702.191269916578;8735.606897689491;10060.949695251476;10186.439745814052;10198.694039178836;10250.38497690141 16:06:25 INFO - PROCESS | 17416 | |3;mootools.html;1459.5986103821451;1492;1675.2042779679646;1794.9371771987983;1829.4328758084994;7704.845903081942;7865.370770338373;7878.803029924247;7896.605169741511;7990.4806187597915;7692.423068269874;7708.884366734504;7743.18696536864;7761.961190194055;7779.883301750464;2381.1903952656094;2383.7377888432256;2395.9577583751125;2399.5800734871414;2413.746556611557;2349.95300093998;2350.2596682045187;2379.202967006055;2385.3678775124604;2397.1250493569896;2289.4390874235837;2336.077249486452;2350.3536527454917;2363.645453182019;2365.3377054424786;2309.642005489152;2343.0627748900492;2359.905603775847;2361.244401791419;2369.18263199196;2297.5060362022245;2306.6194077977116;2313.0747700919596;2320.744718081027;2321.8839058047197;7844.21557844211;7845.293923546851;7851.489653172583;7871.567063811488;7914.960425197894;4697.436307643105;4824.1316563018645;4857.80568777252;4872.3909511311085;4886.193778026622;3068.6777888321853;3112.813231206135;3133.9686603134132;3145.716885480295;3157.1160075178987;978.535195782005;992.4293531219578;997.7056768253383;1017.959281628734;1051.7318083888636;10738.731531711614;10780.19148563853;10810.72973175669;10893.618723344724;10894.836577451344;4206.284931561642;4326.697131200849;4336.588024137702;4377.934330985037;4391.231534481453;8714.607842646968;8772.122787721304;8808.691695790745;8810.691625793066;8841.778955526162;4699.224627936353;4710.528947105262;4710.740909249956;4726.527347265246;4732.574068333866;4312.978435107867;4314.158739045919;4323.610875021263;4344.891377715582;4363.432753741993;3587.587427445825;3610.187707765732;3644.398674218777;3670.2659468106485;3688.354537955847;1125.0268517732102;1127.565887133443;1136.960206392789;1144.2390810111349;1158.3050169897995;1297.7858653322285;1299.330844615024;1334.7130366971148;1336.9933150334186;1349.5479014530047;7307.7807665770115;7325.4139668826365;7448.255174482509;7463.9626801866725;7486.401087912954;1059.4067322299536;1067.5089458849016;1129.3167633581565;1142.3945308986251;1143.5940241214416;5621.7189140542805;5733.054046082433;5753.539716822728;5796.290094422071;5815.069588865761;9290.210332121846;9372.8594071089;9745.122938935388;9766.316357855025;9816.263780216512;9538.380005299634;9582.856257156149;9607.279454040974;9608.423494590206;9621.567029483691;7433.293837085468;7452.143003554552;7507.924920750832;7574.431917606202;7591.658375373121;7179.461540384387;7197.712091516491;7221.494495385273;7252.166000909963;7253.709851605877;8268.958655206685;8381.37139714536;8637.049924508425;8646.524441155796;8746.912530874864;8688.869666954874;8868.955655221682;8942.150495702897;8951.597178126869;9015.504147271962;6800.693968771516;6845.315468453115;6877.140357455318;6885.862282754417;6891.310868913269;7361.227071157451;7361.30067643573;7377.299156580117;7389.334959853424;7412.703491860481;6293.402126797947;6789.15135608049;7184.425245980414;7429.851402971803;7499.812504687427;6823.351781580742;6854.074699915647;6920.653967301514;7009;7064.2935706431;6919.37725604698;6948.722051117898;7009.439244860297;7019.929800702132;7025;6400.9374006990265;6555.016747487915;6602.570832895846;6640.169978752656;6643.634600097041;6674.666266686743;6694.397504224643;6714.563553369211;6725.159355080615;6741.865162696817 16:06:25 INFO - PROCESS | 17416 | |4;prototype.html;339.45517444501576;349.80410969856877;350.2102758280078;357.06983308481387;359.75356880536833;6252.155958945541;6286.968565157168;6337.778177763774;6387.361263873616;6487.253965793935;6298.748050078003;6337.746490140389;6351.364863513646;6356.809295721136;6380.202474690664;4821.614270858323;4830.082284365977;4835.226363781796;4835.443923948747;4844.467108618049;4836.927446088294;4839.05638400512;4842.29786680931;4845.297431872376;4855.6115510759055;4727.432708075035;4813.711177329354;4816.422029356465;4820.662553621248;4824.083424149418;4793.113274044278;4794.208955522335;4795.448523419816;4802.18362878308;4808;4180.728252663597;4180.9338618652355;4181.958180418218;4192.4759405074365;4197.349410841294;5962.522998160137;6048.243969503812;6061.757529698807;6068.787592434243;6083.756649734005;5599.1041433370465;5630.887382252332;5639.943600563983;5646;5646.04017317053;6700.597964122168;6711.261761206263;6735.326467353275;6736.393724564764;6738.35985581369;4649.302604609302;4655.627549796042;4658.95341046592;4662.603678687282;4674.672772905898;6926.445884329241;6973.686184121727;6979.4765392595755;7008.474364422637;7023.227444981048;4732.834350797705;4735.337052812609;4740.857774266778;4749.643776716691;4756.500567440438;4796.760161991956;4806.615470762331;4816.710997340171;4817.397825271841;4831.879203019953;5487.670739755547;5546.362168350692;5563.777448902079;5566.805161819317;5567.47109024642;6678.465722742169;6711.597304161766;6734.696938637773;6737;6743;1663.0271291294728;1690.5182023123596;1702.3445973300368;1705.4883534939718;1708.2910592104386;1106.31961343773;1117.9720506987228;1118.2731224703846;1129.836173754801;1132.5016992523263;6213.96893015532;6219.098230756515;6223;6236.844078898064;6243.157173781572;6730.629815360202;6784.966075169593;6787.423069039187;6799.456043516507;6799.93200067993;6018.3680713524445;6161.106639537242;6163.291221509584;6198.0702894565275;6240.7503699852405;3679.1721862580707;3704.1665625234646;3704.3147017801793;3706.184639379332;3706.8887933362043;7046;7050.471214658921;7059.92940070603;7065.858682826315;7086.2205157432645;6779.796606101825;6885;6947.82630434233;6963.4777391695825;6965.860682786316;7031.92968070323;7051.612161331176;7057.929420705727;7076.32774886385;7081.46888983318;6751.493637977073;6785.762498312535;6799.014142949343;6799.490038247251;6800.081988931431;6538.934610654022;6700.2964688708935;6714.462842972453;6728.226253980855;6734.831629209309;7055.6824942876665;7062.682179302046;7078.716851326095;7081.291870812877;7092.716291348494;4740.6444516660695;4742.739149346819;4745.762711864324;4748.976255118702;4764.237721964608;6796.72813087471;6804.489663275175;6841.965790171017;6842.349976752201;6980.917957716562;6808.93191068083;6830.180378354629;6833.624150671761;6845.383915447434;6860.279670634512;6774.254831968578;6794.946783248604;6795.592264464148;6810.897836532555;6824.624645644339;6536.182977127859;6647.7008534617025;6689.130413046273;6694.163229596301;6699.296573859675;6677.165354330708;6815.727370905108;6831.89752153728;6845.247022827584;6855.07456493367;6571.3757193066585;6601.306862779339;6602.240742314695;6614.603123812587;6652.301508341555 16:06:25 INFO - PROCESS | 17416 | |5;yui.html;666.7099811581962;679.5175425447932;709.1316866493277;756.576317262333;759.3317880265365;12566.623001309952;12587.181833180837;12827.102102852792;12838.80741788874;12993.285369304684;12017.339046352447;12027.759444811121;12059.638210853667;12074.939625301884;12105.515779368836;660.5376236634352;669.7555392281806;800.9439339246255;812.0296245986063;813.1096449387941;818.5947955761906;819.7253919936799;820.0610301205116;824.2993455562754;824.8020475085996;861.2291998661194;861.6682577207757;862.6463150108457;863.080818927843;863.3309185381316;852.8933883264592;853.1809462915609;854.273867212864;854.2952064546743;854.5470900422786;624.2415465209792;628.5003422279299;631.28664608992;631.9304876463585;633.8003528888431;12043.879561204363;12159.331236781973;12188.451519681636;12214.450349734283;12241.571544995883;11857.229280096852;11990.340531270776;12041.81937270933;12069.93965030178;12264.325462099581;10147.492625368703;10159.288849780518;10234.641787537475;10370.274080814346;10625.521851516623;3564.821758912044;3582.9967609069504;3590.0665826885197;3632.945505817415;3637.5453068366455;47677;47922.281165782544;48019;48310.27534586984;50499.24251136236;9090.727278181665;9146.451212927246;9277.118673725985;9366.29752768545;9494.525273736286;16661.50015499537;16743.16284185786;16920.661586768194;16925.661486770197;16953.745693814602;6938.749136384148;7031.929680703128;7092.255313192144;7184.568925864361;7405.7778266652085;4269.402283680287;4289.206496798102;4318.093200427883;4323.437953066082;4360.694751367438;2979.642442906865;2997.1757766614355;2999.085278989929;3002;3019.788614796987;549.884524249912;571.4571157400486;572.0047118014625;576.5301279457229;579.9768009279666;528.4926470588279;529.4890430734359;610.487190759764;615.8983767678283;656.0814859197067;7906.920930790733;7997.800054998555;8107.351411887035;8157.347412207009;8506.106858779738;501.86951392637445;609.2171559545963;612.2469362683923;614.7663887722637;630.3475902440952;3749.6250374962833;3915.334393153171;3947.624975627311;4118.91762164755;4147.668186545069;49756.253656195186;50256.24615630769;50945.49054509481;51100;51134;49077.50922490729;49375;50620;51269.743651281504;51288.74355628198;42600.360994585106;42812.143757125305;43104.56895431005;45952.3107153393;46519.30221046687;8234.794130146794;8392.916070839457;8486.830263394573;8519.322020466176;8843.778905527413;34297.65702342945;34466.65533344735;35276.82361588176;35345.823270883484;35350.82324588361;39300.410493843185;40627;43612.56387436212;43803.561964381224;43889.34165987577;10820.67537973862;11140.554377824796;11170.385628790495;11243.775124497628;11372.545098196311;10709.143268538654;10968.177386696188;11019.669409917715;11178.944105279747;11184.328940263611;10646.946765266433;10700.892991070301;10715.732106697084;10848.945755271488;11286.943565282121;11302.491387887729;11337.09303255721;11440.141989350666;11657.591984280509;11840.585579504675;10272.948635256776;10867.076298514714;10868;11074.833877491683;11206.215564910379;9214.308926830381;9222.723318300461;9391.671291504765;9528.85706714386;9560.808783824423;8919.643214271357;9046.728598142066;9147.176754092163;9186.632534698538;9736.75658108553 16:06:25 INFO - PROCESS | 17416 | __end_tp_report 16:06:25 INFO - PROCESS | 17416 | __start_cc_report 16:06:25 INFO - PROCESS | 17416 | _x_x_mozilla_cycle_collect,295 16:06:25 INFO - PROCESS | 17416 | __end_cc_report 16:06:25 INFO - PROCESS | 17416 | __startTimestamp1452643585332__endTimestamp 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | ------- Summary: start ------- 16:06:25 INFO - PROCESS | 17416 | Number of tests: 6 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#0] dojo.html Cycles:165 Average:5344.16 Median:5601.13 stddev:598.75 (10.7%) stddev-sans-first:576.88 16:06:25 INFO - PROCESS | 17416 | Values: 3217.9 3225.9 3270.6 3304.6 3306.5 5227.6 5327.8 5396.9 5414.0 5423.6 5244.4 5365.6 5463.3 5491.1 5509.8 4512.9 4818.3 4853.2 4855.0 4864.5 4776.4 4790.9 4812.5 4837.1 4927.0 4811.2 4832.2 4889.6 4893.1 4903.9 4836.7 4839.4 4855.7 4886.4 4904.8 4791.8 4833.3 4859.6 4872.0 4879.2 5267.4 5324.6 5338.2 5344.7 5346.9 5693.6 5697.6 5703.1 5716.2 5720.9 5669.2 5720.9 5721.9 5765.5 5794.4 5384.5 5405.6 5435.1 5442.5 5498.3 5829.7 5837.9 5875.5 5878.0 5889.1 5602.6 5636.0 5640.1 5660.3 5666.7 5806.9 5808.3 5812.2 5817.9 5848.3 5714.7 5732.0 5759.3 5760.1 5770.7 5581.5 5670.5 5756.4 5759.9 5843.9 4356.5 4374.5 4375.8 4384.1 4393.0 3910.3 3933.6 3955.4 3971.2 4001.2 5276.8 5316.9 5348.2 5369.7 5423.1 5711.2 5714.5 5744.7 5745.9 5773.8 5302.1 5389.2 5409.5 5413.0 5459.4 4874.9 4937.9 4977.8 4991.5 5022.2 5887.2 5890.2 5900.8 5902.3 5907.9 5693.1 5730.4 5746.7 5772.5 5846.3 5939.5 5980.3 6007.0 6007.2 6056.6 5719.1 5720.5 5725.0 5736.8 5738.2 5691.3 5749.9 5761.0 5822.8 5831.6 5700.7 5712.6 5724.3 5735.8 5775.2 5598.4 5624.8 5626.6 5630.5 5646.0 5408.2 5501.8 5526.0 5566.1 5584.4 5702.1 5702.5 5736.2 5755.6 5759.7 5601.1 5612.9 5614.0 5620.9 5621.8 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#1] ext.html Cycles:180 Average:46584.74 Median:19759.02 stddev:79082.91 (400.2%) stddev-sans-first:79229.18 16:06:25 INFO - PROCESS | 17416 | Values: 536.2 541.3 544.7 565.3 603.0 28943.4 36503.8 36618.6 36691.6 36914.0 39661.0 39721.6 40085.0 40131.8 40168.8 8362.0 8573.4 8615.3 8624.8 8692.2 8452.1 8561.6 8570.7 8580.4 8582.7 8484.2 8583.5 8604.5 8605.9 8609.5 8572.8 8712.0 8765.4 8810.6 8813.0 8682.6 8818.5 8824.8 8829.7 8830.1 40246.2 40912.2 40942.6 40977.2 41022.4 3368.3 3368.4 3436.2 3598.4 3694.9 29690.9 30145.4 30402.8 30646.7 31137.4 3747.7 3819.4 3824.5 3995.6 4105.7 259841.0 261534.0 261891.0 262685.0 263174.0 52468.0 52879.0 57910.4 60613.7 61680.7 55260.7 55747.0 55781.0 55787.7 55953.0 14274.0 14417.4 14429.9 14486.4 14490.1 10349.3 10363.7 10411.7 10437.9 10445.1 20376.8 20755.5 20792.4 20836.6 20838.9 7294.2 7452.4 7456.1 7569.0 7583.4 872.1 916.3 960.0 998.1 1076.0 28692.1 30774.7 31208.0 31327.4 31461.8 1025.0 1029.1 1049.6 1054.1 1095.5 14419.4 14546.2 14575.9 14819.4 14876.8 326962.0 330207.0 330592.0 331467.0 332313.0 51903.5 52035.7 52094.2 52154.2 52227.0 1326.4 1359.0 1365.7 1367.7 1372.7 27530.0 28413.4 28443.3 28508.7 28668.6 47166.5 47182.0 47234.3 47254.0 47266.8 307943.0 309755.0 311176.0 311330.0 312702.0 32043.4 32326.0 32705.3 32792.7 32958.2 37796.4 38060.8 38210.8 38275.0 38640.0 34547.0 35633.6 35836.8 35919.6 36191.5 34943.3 35845.6 36005.8 36187.3 36228.8 34945.7 35258.5 35296.0 35393.8 35511.3 30611.2 32242.2 32330.0 32453.5 32912.5 24651.0 25025.4 25036.9 25100.4 25497.0 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#2] jquery.html Cycles:180 Average:25724.47 Median:463367.00 stddev:78551.04 (17.0%) stddev-sans-first:78748.31 16:06:25 INFO - PROCESS | 17416 | Values: 364.2 367.4 367.4 370.4 370.9 15543.0 16546.9 16887.2 17376.7 17486.0 15189.2 15218.0 15706.8 15742.4 15777.2 4897.3 5096.3 5129.2 5131.7 5155.9 5025.4 5066.4 5132.6 5141.8 5287.7 5123.2 5218.6 5275.5 5339.2 5345.7 5265.9 5276.1 5298.2 5684.6 6107.8 5404.8 5425.3 5433.1 5438.8 5469.8 15734.4 19245.0 19791.7 19870.1 19880.3 2039.7 2074.4 2133.2 2285.4 2306.3 10250.3 12000.4 12012.3 12174.9 12426.9 1834.8 1855.8 1885.7 1894.1 1918.5 53809.2 54518.5 55868.4 56007.0 56099.4 10211.4 10233.2 10263.8 10303.6 10352.8 13318.9 13413.9 13433.2 13442.1 13467.0 6990.5 7096.5 7117.1 7140.6 7175.2 6556.8 6598.5 6629.1 6641.4 6644.6 4475.9 4531.8 4536.8 4550.8 4567.2 1838.0 1893.5 1924.1 1965.9 1973.4 780.3 802.4 852.8 871.9 883.1 15227.6 15495.4 15759.7 15815.8 15826.8 934.3 950.5 952.5 997.2 1018.9 9383.9 9433.2 9548.1 9614.0 9818.7 459333.0 467401.0 469852.0 482956.3 520434.0 72093.6 72727.6 73854.0 74354.0 75459.6 1099.6 1120.7 1137.7 1146.5 1147.6 14128.7 14931.6 14953.7 15148.5 15326.3 32340.4 32806.3 32917.0 34271.8 34482.5 37800.8 38999.8 39138.0 39446.2 39830.4 7105.9 7155.6 7197.4 7312.2 7493.4 9771.3 9773.8 10705.5 11025.4 11074.3 9437.1 9481.7 9576.1 9653.2 9878.1 8760.0 9005.5 9257.4 9653.6 9943.5 9367.2 9649.5 9907.6 10072.5 10305.9 7549.0 7571.6 7620.8 7670.3 7702.2 8735.6 10060.9 10186.4 10198.7 10250.4 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#3] mootools.html Cycles:180 Average:5528.53 Median:6621.37 stddev:2838.69 (42.9%) stddev-sans-first:2830.17 16:06:25 INFO - PROCESS | 17416 | Values: 1459.6 1492.0 1675.2 1794.9 1829.4 7704.8 7865.4 7878.8 7896.6 7990.5 7692.4 7708.9 7743.2 7762.0 7779.9 2381.2 2383.7 2396.0 2399.6 2413.7 2350.0 2350.3 2379.2 2385.4 2397.1 2289.4 2336.1 2350.4 2363.6 2365.3 2309.6 2343.1 2359.9 2361.2 2369.2 2297.5 2306.6 2313.1 2320.7 2321.9 7844.2 7845.3 7851.5 7871.6 7915.0 4697.4 4824.1 4857.8 4872.4 4886.2 3068.7 3112.8 3134.0 3145.7 3157.1 978.5 992.4 997.7 1018.0 1051.7 10738.7 10780.2 10810.7 10893.6 10894.8 4206.3 4326.7 4336.6 4377.9 4391.2 8714.6 8772.1 8808.7 8810.7 8841.8 4699.2 4710.5 4710.7 4726.5 4732.6 4313.0 4314.2 4323.6 4344.9 4363.4 3587.6 3610.2 3644.4 3670.3 3688.4 1125.0 1127.6 1137.0 1144.2 1158.3 1297.8 1299.3 1334.7 1337.0 1349.5 7307.8 7325.4 7448.3 7464.0 7486.4 1059.4 1067.5 1129.3 1142.4 1143.6 5621.7 5733.1 5753.5 5796.3 5815.1 9290.2 9372.9 9745.1 9766.3 9816.3 9538.4 9582.9 9607.3 9608.4 9621.6 7433.3 7452.1 7507.9 7574.4 7591.7 7179.5 7197.7 7221.5 7252.2 7253.7 8269.0 8381.4 8637.0 8646.5 8746.9 8688.9 8869.0 8942.2 8951.6 9015.5 6800.7 6845.3 6877.1 6885.9 6891.3 7361.2 7361.3 7377.3 7389.3 7412.7 6293.4 6789.2 7184.4 7429.9 7499.8 6823.4 6854.1 6920.7 7009.0 7064.3 6919.4 6948.7 7009.4 7019.9 7025.0 6400.9 6555.0 6602.6 6640.2 6643.6 6674.7 6694.4 6714.6 6725.2 6741.9 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#4] prototype.html Cycles:180 Average:5581.56 Median:6269.56 stddev:1676.41 (26.7%) stddev-sans-first:1634.29 16:06:25 INFO - PROCESS | 17416 | Values: 339.5 349.8 350.2 357.1 359.8 6252.2 6287.0 6337.8 6387.4 6487.3 6298.7 6337.7 6351.4 6356.8 6380.2 4821.6 4830.1 4835.2 4835.4 4844.5 4836.9 4839.1 4842.3 4845.3 4855.6 4727.4 4813.7 4816.4 4820.7 4824.1 4793.1 4794.2 4795.4 4802.2 4808.0 4180.7 4180.9 4182.0 4192.5 4197.3 5962.5 6048.2 6061.8 6068.8 6083.8 5599.1 5630.9 5639.9 5646.0 5646.0 6700.6 6711.3 6735.3 6736.4 6738.4 4649.3 4655.6 4659.0 4662.6 4674.7 6926.4 6973.7 6979.5 7008.5 7023.2 4732.8 4735.3 4740.9 4749.6 4756.5 4796.8 4806.6 4816.7 4817.4 4831.9 5487.7 5546.4 5563.8 5566.8 5567.5 6678.5 6711.6 6734.7 6737.0 6743.0 1663.0 1690.5 1702.3 1705.5 1708.3 1106.3 1118.0 1118.3 1129.8 1132.5 6214.0 6219.1 6223.0 6236.8 6243.2 6730.6 6785.0 6787.4 6799.5 6799.9 6018.4 6161.1 6163.3 6198.1 6240.8 3679.2 3704.2 3704.3 3706.2 3706.9 7046.0 7050.5 7059.9 7065.9 7086.2 6779.8 6885.0 6947.8 6963.5 6965.9 7031.9 7051.6 7057.9 7076.3 7081.5 6751.5 6785.8 6799.0 6799.5 6800.1 6538.9 6700.3 6714.5 6728.2 6734.8 7055.7 7062.7 7078.7 7081.3 7092.7 4740.6 4742.7 4745.8 4749.0 4764.2 6796.7 6804.5 6842.0 6842.3 6980.9 6808.9 6830.2 6833.6 6845.4 6860.3 6774.3 6794.9 6795.6 6810.9 6824.6 6536.2 6647.7 6689.1 6694.2 6699.3 6677.2 6815.7 6831.9 6845.2 6855.1 6571.4 6601.3 6602.2 6614.6 6652.3 16:06:25 INFO - PROCESS | 17416 | 16:06:25 INFO - PROCESS | 17416 | [#5] yui.html Cycles:180 Average:13202.80 Median:47799.64 stddev:15185.59 (31.8%) stddev-sans-first:15199.01 16:06:25 INFO - PROCESS | 17416 | Values: 666.7 679.5 709.1 756.6 759.3 12566.6 12587.2 12827.1 12838.8 12993.3 12017.3 12027.8 12059.6 12074.9 12105.5 660.5 669.8 800.9 812.0 813.1 818.6 819.7 820.1 824.3 824.8 861.2 861.7 862.6 863.1 863.3 852.9 853.2 854.3 854.3 854.5 624.2 628.5 631.3 631.9 633.8 12043.9 12159.3 12188.5 12214.5 12241.6 11857.2 11990.3 12041.8 12069.9 12264.3 10147.5 10159.3 10234.6 10370.3 10625.5 3564.8 3583.0 3590.1 3632.9 3637.5 47677.0 47922.3 48019.0 48310.3 50499.2 9090.7 9146.5 9277.1 9366.3 9494.5 16661.5 16743.2 16920.7 16925.7 16953.7 6938.7 7031.9 7092.3 7184.6 7405.8 4269.4 4289.2 4318.1 4323.4 4360.7 2979.6 2997.2 2999.1 3002.0 3019.8 549.9 571.5 572.0 576.5 580.0 528.5 529.5 610.5 615.9 656.1 7906.9 7997.8 8107.4 8157.3 8506.1 501.9 609.2 612.2 614.8 630.3 3749.6 3915.3 3947.6 4118.9 4147.7 49756.3 50256.2 50945.5 51100.0 51134.0 49077.5 49375.0 50620.0 51269.7 51288.7 42600.4 42812.1 43104.6 45952.3 46519.3 8234.8 8392.9 8486.8 8519.3 8843.8 34297.7 34466.7 35276.8 35345.8 35350.8 39300.4 40627.0 43612.6 43803.6 43889.3 10820.7 11140.6 11170.4 11243.8 11372.5 10709.1 10968.2 11019.7 11178.9 11184.3 10646.9 10700.9 10715.7 10848.9 11286.9 11302.5 11337.1 11440.1 11657.6 11840.6 10272.9 10867.1 10868.0 11074.8 11206.2 9214.3 9222.7 9391.7 9528.9 9560.8 8919.6 9046.7 9147.2 9186.6 9736.8 16:06:25 INFO - PROCESS | 17416 | -------- Summary: end -------- 16:06:25 INFO - PROCESS | 17416 | 16:06:26 INFO - TEST-INFO | 17416: exit 0 16:06:26 INFO - TEST-OK | dromaeo_css | took 1109814ms 16:06:26 INFO - TEST-START | kraken 16:06:26 INFO - operating with platform_type : linux_ 16:06:26 INFO - Initialising browser for kraken test... 16:06:26 INFO - TEST-INFO | started process 17655 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt0bpo5/profile http://localhost:48939/getInfo.html) 16:06:29 INFO - PROCESS | 17655 | 16:06:29 INFO - PROCESS | 17655 | (process:17729): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:06:30 INFO - PROCESS | 17655 | __metrics Screen width/height:1600/1200 16:06:30 INFO - PROCESS | 17655 | colorDepth:24 16:06:30 INFO - PROCESS | 17655 | Browser inner width/height: 1024/697 16:06:30 INFO - PROCESS | 17655 | __metrics 16:06:30 INFO - PROCESS | 17655 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:06:31 INFO - TEST-INFO | 17655: exit 0 16:06:31 INFO - Browser initialized. 16:06:31 INFO - Running cycle 1/1 for kraken test... 16:06:31 INFO - TEST-INFO | started process 17778 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt0bpo5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:32 INFO - PROCESS | 17778 | 16:06:32 INFO - PROCESS | 17778 | (process:17836): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:06:42 INFO - PROCESS | 17778 | RSS: Main: 150175744 16:06:42 INFO - PROCESS | 17778 | 16:06:45 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48939/tests/kraken/driver.html?testName=audio-beat-detection) 16:06:45 INFO - PROCESS | 17778 | RSS: Main: 151031808 16:06:45 INFO - PROCESS | 17778 | 16:06:48 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48939/tests/kraken/driver.html?testName=audio-dft) 16:06:49 INFO - PROCESS | 17778 | RSS: Main: 153141248 16:06:49 INFO - PROCESS | 17778 | 16:06:52 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48939/tests/kraken/driver.html?testName=audio-fft) 16:06:52 INFO - PROCESS | 17778 | RSS: Main: 147324928 16:06:52 INFO - PROCESS | 17778 | 16:06:54 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48939/tests/kraken/driver.html?testName=audio-oscillator) 16:06:55 INFO - PROCESS | 17778 | RSS: Main: 148414464 16:06:55 INFO - PROCESS | 17778 | 16:06:57 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:06:58 INFO - PROCESS | 17778 | RSS: Main: 148365312 16:06:58 INFO - PROCESS | 17778 | 16:07:01 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48939/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:01 INFO - PROCESS | 17778 | RSS: Main: 147619840 16:07:01 INFO - PROCESS | 17778 | 16:07:05 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48939/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:05 INFO - PROCESS | 17778 | RSS: Main: 147849216 16:07:05 INFO - PROCESS | 17778 | 16:07:08 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48939/tests/kraken/driver.html?testName=json-parse-financial) 16:07:09 INFO - PROCESS | 17778 | RSS: Main: 148267008 16:07:09 INFO - PROCESS | 17778 | 16:07:10 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:11 INFO - PROCESS | 17778 | RSS: Main: 149655552 16:07:11 INFO - PROCESS | 17778 | 16:07:13 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:13 INFO - PROCESS | 17778 | RSS: Main: 149745664 16:07:13 INFO - PROCESS | 17778 | 16:07:15 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:16 INFO - PROCESS | 17778 | RSS: Main: 150310912 16:07:16 INFO - PROCESS | 17778 | 16:07:18 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:19 INFO - PROCESS | 17778 | RSS: Main: 149889024 16:07:19 INFO - PROCESS | 17778 | 16:07:22 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:22 INFO - PROCESS | 17778 | RSS: Main: 150036480 16:07:22 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | Cycle 1(1): loaded http://localhost:48939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48939/tests/kraken/driver.html?testName=ai-astar) 16:07:24 INFO - PROCESS | 17778 | RSS: Main: 149401600 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | __start_tp_report 16:07:24 INFO - PROCESS | 17778 | _x_x_mozilla_page_load 16:07:24 INFO - PROCESS | 17778 | _x_x_mozilla_page_load_details 16:07:24 INFO - PROCESS | 17778 | |i|pagename|runs| 16:07:24 INFO - PROCESS | 17778 | |0;ai-astar;112;105;113;111;110;124;113;109;112;111 16:07:24 INFO - PROCESS | 17778 | |1;audio-beat-detection;154;124;154;159;127;159;150;131;163;123 16:07:24 INFO - PROCESS | 17778 | |2;audio-dft;161;162;161;162;165;165;165;167;168;163 16:07:24 INFO - PROCESS | 17778 | |3;audio-fft;76;72;75;72;75;75;140;72;71;71 16:07:24 INFO - PROCESS | 17778 | |4;audio-oscillator;97;97;139;97;97;97;148;96;97;140 16:07:24 INFO - PROCESS | 17778 | |5;imaging-gaussian-blur;111;110;111;109;110;110;110;109;110;109 16:07:24 INFO - PROCESS | 17778 | |6;imaging-darkroom;147;147;148;148;148;148;147;147;148;147 16:07:24 INFO - PROCESS | 17778 | |7;imaging-desaturate;97;96;96;96;96;97;96;96;97;95 16:07:24 INFO - PROCESS | 17778 | |8;json-parse-financial;59;60;66;60;58;63;60;60;59;56 16:07:24 INFO - PROCESS | 17778 | |9;json-stringify-tinderbox;67;67;67;68;68;69;68;68;69;68 16:07:24 INFO - PROCESS | 17778 | |10;stanford-crypto-aes;83;82;85;83;83;81;91;91;82;82 16:07:24 INFO - PROCESS | 17778 | |11;stanford-crypto-ccm;118;115;116;115;124;119;118;121;117;115 16:07:24 INFO - PROCESS | 17778 | |12;stanford-crypto-pbkdf2;134;149;143;141;149;157;149;143;141;133 16:07:24 INFO - PROCESS | 17778 | |13;stanford-crypto-sha256-iterative;69;67;68;71;67;66;67;67;70;68 16:07:24 INFO - PROCESS | 17778 | __end_tp_report 16:07:24 INFO - PROCESS | 17778 | __start_cc_report 16:07:24 INFO - PROCESS | 17778 | _x_x_mozilla_cycle_collect,743 16:07:24 INFO - PROCESS | 17778 | __end_cc_report 16:07:24 INFO - PROCESS | 17778 | __startTimestamp1452643644652__endTimestamp 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | ------- Summary: start ------- 16:07:24 INFO - PROCESS | 17778 | Number of tests: 14 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.83 (4.3%) stddev-sans-first:5.12 16:07:24 INFO - PROCESS | 17778 | Values: 112.0 105.0 113.0 111.0 110.0 124.0 113.0 109.0 112.0 111.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:154.00 stddev:16.14 (10.5%) stddev-sans-first:16.74 16:07:24 INFO - PROCESS | 17778 | Values: 154.0 124.0 154.0 159.0 127.0 159.0 150.0 131.0 163.0 123.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#2] audio-dft Cycles:10 Average:163.90 Median:165.00 stddev:2.47 (1.5%) stddev-sans-first:2.39 16:07:24 INFO - PROCESS | 17778 | Values: 161.0 162.0 161.0 162.0 165.0 165.0 165.0 167.0 168.0 163.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:21.20 (28.8%) stddev-sans-first:22.44 16:07:24 INFO - PROCESS | 17778 | Values: 76.0 72.0 75.0 72.0 75.0 75.0 140.0 72.0 71.0 71.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:97.00 stddev:22.09 (22.8%) stddev-sans-first:22.89 16:07:24 INFO - PROCESS | 17778 | Values: 97.0 97.0 139.0 97.0 97.0 97.0 148.0 96.0 97.0 140.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 16:07:24 INFO - PROCESS | 17778 | Values: 111.0 110.0 111.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:07:24 INFO - PROCESS | 17778 | Values: 147.0 147.0 148.0 148.0 148.0 148.0 147.0 147.0 148.0 147.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 16:07:24 INFO - PROCESS | 17778 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 95.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.00 stddev:2.73 (4.5%) stddev-sans-first:2.86 16:07:24 INFO - PROCESS | 17778 | Values: 59.0 60.0 66.0 60.0 58.0 63.0 60.0 60.0 59.0 56.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 16:07:24 INFO - PROCESS | 17778 | Values: 67.0 67.0 67.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.68 (4.4%) stddev-sans-first:3.88 16:07:24 INFO - PROCESS | 17778 | Values: 83.0 82.0 85.0 83.0 83.0 81.0 91.0 91.0 82.0 82.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:2.94 (2.5%) stddev-sans-first:3.11 16:07:24 INFO - PROCESS | 17778 | Values: 118.0 115.0 116.0 115.0 124.0 119.0 118.0 121.0 117.0 115.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:146.00 stddev:7.34 (5.0%) stddev-sans-first:6.86 16:07:24 INFO - PROCESS | 17778 | Values: 134.0 149.0 143.0 141.0 149.0 157.0 149.0 143.0 141.0 133.0 16:07:24 INFO - PROCESS | 17778 | 16:07:24 INFO - PROCESS | 17778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 16:07:24 INFO - PROCESS | 17778 | Values: 69.0 67.0 68.0 71.0 67.0 66.0 67.0 67.0 70.0 68.0 16:07:24 INFO - PROCESS | 17778 | -------- Summary: end -------- 16:07:24 INFO - PROCESS | 17778 | 16:07:25 INFO - TEST-INFO | 17778: exit 0 16:07:25 INFO - TEST-OK | kraken | took 59527ms 16:07:25 INFO - TEST-START | v8_7 16:07:25 INFO - operating with platform_type : linux_ 16:07:25 INFO - Initialising browser for v8_7 test... 16:07:25 INFO - TEST-INFO | started process 18065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG76u0t/profile http://localhost:48939/getInfo.html) 16:07:28 INFO - PROCESS | 18065 | 16:07:28 INFO - PROCESS | 18065 | (process:18135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:29 INFO - PROCESS | 18065 | __metrics Screen width/height:1600/1200 16:07:29 INFO - PROCESS | 18065 | colorDepth:24 16:07:29 INFO - PROCESS | 18065 | Browser inner width/height: 1024/697 16:07:29 INFO - PROCESS | 18065 | __metrics 16:07:29 INFO - PROCESS | 18065 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:07:30 INFO - TEST-INFO | 18065: exit 0 16:07:30 INFO - Browser initialized. 16:07:30 INFO - Running cycle 1/1 for v8_7 test... 16:07:30 INFO - TEST-INFO | started process 18184 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG76u0t/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:31 INFO - PROCESS | 18184 | 16:07:31 INFO - PROCESS | 18184 | (process:18245): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:07:42 INFO - PROCESS | 18184 | RSS: Main: 150790144 16:07:42 INFO - PROCESS | 18184 | 16:08:04 INFO - PROCESS | 18184 | Cycle 1(1): loaded http://localhost:48939/tests/v8_7/run.html (next: http://localhost:48939/tests/v8_7/run.html) 16:08:05 INFO - PROCESS | 18184 | RSS: Main: 146374656 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | __start_tp_report 16:08:05 INFO - PROCESS | 18184 | _x_x_mozilla_page_load 16:08:05 INFO - PROCESS | 18184 | _x_x_mozilla_page_load_details 16:08:05 INFO - PROCESS | 18184 | |i|pagename|runs| 16:08:05 INFO - PROCESS | 18184 | |0;Richards;167.78523489932886 16:08:05 INFO - PROCESS | 18184 | |1;DeltaBlue;187.68768768768768 16:08:05 INFO - PROCESS | 18184 | |2;Encrypt;280.74115665356544 16:08:05 INFO - PROCESS | 18184 | |3;Decrypt;5256.544502617801 16:08:05 INFO - PROCESS | 18184 | |4;RayTrace;1059.322033898305 16:08:05 INFO - PROCESS | 18184 | |5;Earley;719.4244604316547 16:08:05 INFO - PROCESS | 18184 | |6;Boyer;12292.682926829268 16:08:05 INFO - PROCESS | 18184 | |7;RegExp;40607.8431372549 16:08:05 INFO - PROCESS | 18184 | |8;Splay;626.5664160401003 16:08:05 INFO - PROCESS | 18184 | |9;NavierStokes;4830.917874396136 16:08:05 INFO - PROCESS | 18184 | __end_tp_report 16:08:05 INFO - PROCESS | 18184 | __startTimestamp1452643685026__endTimestamp 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | ------- Summary: start ------- 16:08:05 INFO - PROCESS | 18184 | Number of tests: 10 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 167.8 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#1] DeltaBlue Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 187.7 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 280.7 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 5256.5 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#4] RayTrace Cycles:1 Average:1059.32 Median:1059.32 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 1059.3 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#5] Earley Cycles:1 Average:719.42 Median:719.42 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 719.4 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 12292.7 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#7] RegExp Cycles:1 Average:40607.84 Median:40607.84 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 40607.8 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#8] Splay Cycles:1 Average:626.57 Median:626.57 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 626.6 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - PROCESS | 18184 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:08:05 INFO - PROCESS | 18184 | Values: 4830.9 16:08:05 INFO - PROCESS | 18184 | -------- Summary: end -------- 16:08:05 INFO - PROCESS | 18184 | 16:08:05 INFO - TEST-INFO | 18184: exit 0 16:08:05 INFO - TEST-OK | v8_7 | took 40367ms 16:08:05 INFO - SUITE-END | took 1209s 16:08:05 INFO - Completed test suite (00:20:09) 16:08:05 INFO - Working with test: dromaeo_css 16:08:05 INFO - Generating results file: dromaeo_css 16:08:05 INFO - Working with test: kraken 16:08:05 INFO - Generating results file: kraken 16:08:05 INFO - javascript benchmark 16:08:05 INFO - Working with test: v8_7 16:08:05 INFO - Generating results file: v8_7 16:08:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:08:06 INFO - process_Request line: dromaeo_css 6916.53 graph.html#tests=[[72,63,43]] 16:08:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:06 INFO - process_Request line: kraken 1506.30 graph.html#tests=[[232,63,43]] 16:08:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:08:06 INFO - process_Request line: v8_7 20288.20 graph.html#tests=[[230,63,43]] 16:08:06 INFO - RETURN: dromaeo_css: 6916.53 16:08:06 INFO - RETURN: kraken: 1506.30 16:08:06 INFO - RETURN: v8_7: 20288.20 16:08:06 INFO - javascript benchmark 16:08:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3217.8551965161564, 3225.9354812903744, 3270.6075270967485, 3304.5869266341706, 3306.5370848081257, 5227.555657769094, 5327.840164795052, 5396.946030539693, 5413.999999999995, 5423.620346575736, 5244.449332820056, 5365.570754339653, 5463.344398672155, 5491.148871924848, 5509.752061157247, 4512.887177820564, 4818.325434439173, 4853.174960256765, 4854.97572512137, 4864.5378689024665, 4776.4268287805335, 4790.904181916359, 4812.494688057756, 4837.105135549917, 4927.014597080581, 4811.158047341702, 4832.154372984731, 4889.633277504166, 4893.143699852511, 4903.926441103386, 4836.685615434985, 4839.37088178538, 4855.708657480563, 4886.413630364379, 4904.779284932187, 4791.808327666924, 4833.250846118857, 4859.562639362474, 4872.0, 4879.194932836078, 5267.420583735786, 5324.5740340772645, 5338.225957236218, 5344.706041167734, 5346.946530534684, 5693.601447898649, 5697.6011679182475, 5703.0589952657765, 5716.1711551825165, 5720.942790572082, 5669.206311116406, 5720.885582288331, 5721.914171287434, 5765.538756899438, 5794.391588883149, 5384.542313903323, 5405.648632838932, 5435.103207970719, 5442.455754424526, 5498.285222920995, 5829.708514574254, 5837.9124313135335, 5875.471207591252, 5877.9999999999145, 5889.146073819272, 5602.635828671123, 5636.0, 5640.125780504029, 5660.264165658438, 5666.6600003999065, 5806.912896306559, 5808.332041815245, 5812.215350927655, 5817.912731309034, 5848.2689663792025, 5714.685692286964, 5731.971340143273, 5759.337676167294, 5760.135979603009, 5770.740316685759, 5581.525570326487, 5670.518005969457, 5756.366799652035, 5759.942400576025, 5843.941560584425, 4356.542563030836, 4374.518802931675, 4375.78121093944, 4384.12317536494, 4393.033532622818, 3910.2961466936226, 3933.62630550103, 3955.426463162883, 3971.205758848242, 4001.239764444746, 5276.841694749163, 5316.893662126736, 5348.171033489815, 5369.731513424314, 5423.05096608092, 5711.228984087178, 5714.457126573052, 5744.741486633112, 5745.85635359111, 5773.826785196451, 5302.125149350314, 5389.245505629215, 5409.459054094559, 5413.0, 5459.372172200168, 4874.902501949941, 4937.901241975141, 4977.776000080005, 4991.47589503097, 5022.2466630005065, 5887.175795388649, 5890.175375447441, 5900.76396944126, 5902.2622172228475, 5907.940920590825, 5693.060644993529, 5730.426957304237, 5746.683932383759, 5772.538196944319, 5846.327672317738, 5939.4951429129005, 5980.252468441445, 6006.978813601786, 6007.189029480965, 6056.606320589148, 5719.084946408721, 5720.542356611378, 5725.0, 5736.770529178953, 5738.196652468741, 5691.3170419549915, 5749.942500574941, 5760.971195143998, 5822.76708931655, 5831.562632802472, 5700.657960522382, 5712.600117991867, 5724.284464441945, 5735.827925162252, 5775.162601422854, 5598.440155984369, 5624.803131890364, 5626.578006649435, 5630.493255607015, 5646.0, 5408.242846001484, 5501.779928802963, 5526.032944234823, 5566.081596536526, 5584.4136365681015, 5702.059160238514, 5702.486776190163, 5736.225609542826, 5755.597108202385, 5759.740811663569, 5601.131824567198, 5612.943870561242, 5614.0, 5620.8875822482505, 5621.775128994958], "unit": "score", "name": "dojo.html", "value": 5305.285720909391}, {"lowerIsBetter": false, "replicates": [536.1555550008735, 541.3044238153973, 544.727636181909, 565.347024187064, 602.9869818704577, 28943.421131577383, 36503.81748091259, 36618.63381366192, 36691.633083669156, 36914.0, 39661.0, 39721.60278397215, 40085.0, 40131.79934100333, 40168.79915600425, 8361.958190209041, 8573.399862009663, 8615.267702245317, 8624.784380390478, 8692.217700406962, 8452.070272270075, 8561.571921403936, 8570.700025499078, 8580.35647326453, 8582.656693732275, 8484.19400156984, 8583.484990900566, 8604.48373097613, 8605.913940860573, 8609.483430994129, 8572.785680357978, 8712.0, 8765.386422950396, 8810.559472026373, 8812.986506551764, 8682.6092825823, 8818.470891746516, 8824.823503529959, 8829.69096081634, 8830.116988301119, 40246.19507609861, 40912.181756364706, 40942.590574094174, 40977.180456390706, 41022.38466423006, 3368.34317308125, 3368.444206705891, 3436.1753179237053, 3598.4062629666337, 3694.907627309312, 29690.85154574235, 30145.397092058036, 30402.847985760152, 30646.69353306461, 31137.37725245505, 3747.7001839852746, 3819.4461803038403, 3824.464574959508, 3995.5604883462797, 4105.712600117993, 259841.0, 261534.0, 261891.0, 262685.0, 263174.0, 52468.0, 52879.0, 57910.42089579134, 60613.696931515944, 61680.69159654263, 55260.72369638126, 55747.0, 55781.0, 55787.72106139525, 55953.0, 14274.0, 14417.42330306776, 14429.85570144306, 14486.420543178365, 14490.130592164292, 10349.327293725884, 10363.740906477398, 10411.739706507398, 10437.947810261052, 10445.11216546587, 20376.796232037785, 20755.481112972295, 20792.37622871316, 20836.583268334853, 20838.895805521177, 7294.197638259787, 7452.403807695371, 7456.142543607554, 7568.962155189189, 7583.355414789805, 872.1191596487594, 916.2578311567652, 960.0, 998.1216529454034, 1075.9515821788038, 28692.13923582296, 30774.692253077632, 31208.0, 31327.37345253082, 31461.842690786856, 1025.041586116983, 1029.145808978546, 1049.58541376156, 1054.0829478353728, 1095.4522738630685, 14419.42322307117, 14546.199959002144, 14575.927120364331, 14819.407223711147, 14876.776848347283, 326962.0, 330207.0, 330592.0, 331467.0, 332313.0, 51903.48096519062, 52035.73982130141, 52094.21858672123, 52154.21768673473, 52227.0, 1326.389860664086, 1359.0079242153283, 1365.7405093032291, 1367.7264547090422, 1372.7185926884965, 27530.0, 28413.431731365672, 28443.28891777722, 28508.714912851436, 28668.569971450863, 47166.52833471621, 47182.0, 47234.29148562843, 47254.0, 47266.76366618145, 307943.0, 309755.0, 311176.0, 311330.0, 312702.0, 32043.35913281768, 32326.0, 32705.34589308248, 32792.67207327896, 32958.17604559809, 37796.43305350477, 38060.80969595134, 38210.80894595509, 38275.0, 38640.0, 34547.0, 35633.64366356407, 35836.82081589576, 35919.64080359163, 36191.457128142574, 34943.301133977686, 35845.641543585276, 36005.819970899975, 36187.27625447529, 36228.81885590555, 34945.65054349424, 35258.471122932664, 35296.0, 35393.82303088468, 35511.28977420489, 30611.2347191322, 32242.193945151557, 32330.0, 32453.51319730159, 32912.506312405814, 24651.0, 25025.374365641004, 25036.874815625804, 25100.372490687147, 25497.0], "unit": "score", "name": "ext.html", "value": 18236.662326318015}, {"lowerIsBetter": false, "replicates": [364.16424306217215, 367.3607922215346, 367.4231456613117, 370.36112705582866, 370.86278077111467, 15543.0, 16546.91726541367, 16887.24007419666, 17376.739348909778, 17486.0, 15189.240537973084, 15218.0, 15706.764398534031, 15742.449014284502, 15777.21113944301, 4897.314375987356, 5096.2865198872005, 5129.153689641204, 5131.666441681297, 5155.896882062375, 5025.447200807908, 5066.36670416198, 5132.563732082777, 5141.82003629873, 5287.735613219324, 5123.180291153398, 5218.556422704075, 5275.498827611371, 5339.172428273624, 5345.65253258537, 5265.868353291179, 5276.103062479368, 5298.23175639532, 5684.63049901755, 6107.847303817396, 5404.7838086476495, 5425.267588875491, 5433.0763770159165, 5438.755256013489, 5469.781208751645, 15734.44929427476, 19245.0, 19791.703124453146, 19870.105845236998, 19880.304189353305, 2039.694045893113, 2074.4295318787304, 2133.200049981257, 2285.440067183534, 2306.342692332694, 10250.282480226388, 12000.399980000964, 12012.279263244145, 12174.939125304405, 12426.875731242662, 1834.7706536682915, 1855.8329750322537, 1885.70771530413, 1894.0624390926441, 1918.4556432072177, 53809.1928621071, 54518.45481545213, 55868.44131558673, 56007.0, 56099.439005610235, 10211.387316761018, 10233.181345492343, 10263.794724105475, 10303.587856485807, 10352.792944141074, 13318.933405333106, 13413.86586134126, 13433.19400835953, 13442.126261792951, 13467.0, 6990.545614535039, 7096.53872498286, 7117.145942486831, 7140.571565706075, 7175.246599107123, 6556.803295901131, 6598.47212223021, 6629.071929929813, 6641.435477984329, 6644.568103073285, 4475.865724028285, 4531.796069176895, 4536.795844186953, 4550.817967281338, 4567.246404343313, 1837.9724304135448, 1893.4887580353227, 1924.1052910396734, 1965.8722183058342, 1973.3685220729228, 780.3289171312666, 802.3781569283851, 852.8038551133274, 871.8866547348804, 883.1301168349171, 15227.61930951713, 15495.380184792482, 15759.68480630381, 15815.841841581667, 15826.76259856103, 934.3412893909913, 950.458238803889, 952.476138124029, 997.2420960070399, 1018.8675472188568, 9383.859242111374, 9433.245340372754, 9548.092931171666, 9613.951930240444, 9818.65634702782, 459333.0, 467401.0, 469852.0, 482956.3408731806, 520434.0, 72093.63953180201, 72727.63636181786, 73854.0, 74354.0, 75459.62270188614, 1099.6481126039591, 1120.7198200449889, 1137.7212582917239, 1146.5012719467059, 1147.6327575175865, 14128.717425651635, 14931.626709332353, 14953.700925981637, 15148.545543633709, 15326.310316036028, 32340.35319293648, 32806.30241828863, 32917.0, 34271.828640856635, 34482.482762758074, 37800.81099594595, 38999.805000975946, 39138.0, 39446.2110757789, 39830.402543962446, 7105.8578828422105, 7155.570665760071, 7197.388222001188, 7312.232215617496, 7493.43799215072, 9771.31600787938, 9773.75565610837, 10705.464726763475, 11025.44872756343, 11074.280171788809, 9437.056294370508, 9481.715548533555, 9576.090271424204, 9653.227741780782, 9878.110970012733, 8760.0, 9005.459672419676, 9257.398269112486, 9653.613855445703, 9943.453110078726, 9367.203787678123, 9649.517524123907, 9907.554160062959, 10072.546735396778, 10305.896941030795, 7549.0, 7571.621418929141, 7620.8475830484185, 7670.348020418327, 7702.191269916578, 8735.606897689491, 10060.949695251476, 10186.439745814052, 10198.694039178836, 10250.38497690141], "unit": "score", "name": "jquery.html", "value": 8111.258870964953}, {"lowerIsBetter": false, "replicates": [1459.5986103821451, 1492.0, 1675.2042779679646, 1794.9371771987983, 1829.4328758084994, 7704.845903081942, 7865.370770338373, 7878.803029924247, 7896.605169741511, 7990.4806187597915, 7692.423068269874, 7708.884366734504, 7743.18696536864, 7761.961190194055, 7779.883301750464, 2381.1903952656094, 2383.7377888432256, 2395.9577583751125, 2399.5800734871414, 2413.746556611557, 2349.95300093998, 2350.2596682045187, 2379.202967006055, 2385.3678775124604, 2397.1250493569896, 2289.4390874235837, 2336.077249486452, 2350.3536527454917, 2363.645453182019, 2365.3377054424786, 2309.642005489152, 2343.0627748900492, 2359.905603775847, 2361.244401791419, 2369.18263199196, 2297.5060362022245, 2306.6194077977116, 2313.0747700919596, 2320.744718081027, 2321.8839058047197, 7844.21557844211, 7845.293923546851, 7851.489653172583, 7871.567063811488, 7914.960425197894, 4697.436307643105, 4824.1316563018645, 4857.80568777252, 4872.3909511311085, 4886.193778026622, 3068.6777888321853, 3112.813231206135, 3133.9686603134132, 3145.716885480295, 3157.1160075178987, 978.535195782005, 992.4293531219578, 997.7056768253383, 1017.959281628734, 1051.7318083888636, 10738.731531711614, 10780.19148563853, 10810.72973175669, 10893.618723344724, 10894.836577451344, 4206.284931561642, 4326.697131200849, 4336.588024137702, 4377.934330985037, 4391.231534481453, 8714.607842646968, 8772.122787721304, 8808.691695790745, 8810.691625793066, 8841.778955526162, 4699.224627936353, 4710.528947105262, 4710.740909249956, 4726.527347265246, 4732.574068333866, 4312.978435107867, 4314.158739045919, 4323.610875021263, 4344.891377715582, 4363.432753741993, 3587.587427445825, 3610.187707765732, 3644.398674218777, 3670.2659468106485, 3688.354537955847, 1125.0268517732102, 1127.565887133443, 1136.960206392789, 1144.2390810111349, 1158.3050169897995, 1297.7858653322285, 1299.330844615024, 1334.7130366971148, 1336.9933150334186, 1349.5479014530047, 7307.7807665770115, 7325.4139668826365, 7448.255174482509, 7463.9626801866725, 7486.401087912954, 1059.4067322299536, 1067.5089458849016, 1129.3167633581565, 1142.3945308986251, 1143.5940241214416, 5621.7189140542805, 5733.054046082433, 5753.539716822728, 5796.290094422071, 5815.069588865761, 9290.210332121846, 9372.8594071089, 9745.122938935388, 9766.316357855025, 9816.263780216512, 9538.380005299634, 9582.856257156149, 9607.279454040974, 9608.423494590206, 9621.567029483691, 7433.293837085468, 7452.143003554552, 7507.924920750832, 7574.431917606202, 7591.658375373121, 7179.461540384387, 7197.712091516491, 7221.494495385273, 7252.166000909963, 7253.709851605877, 8268.958655206685, 8381.37139714536, 8637.049924508425, 8646.524441155796, 8746.912530874864, 8688.869666954874, 8868.955655221682, 8942.150495702897, 8951.597178126869, 9015.504147271962, 6800.693968771516, 6845.315468453115, 6877.140357455318, 6885.862282754417, 6891.310868913269, 7361.227071157451, 7361.30067643573, 7377.299156580117, 7389.334959853424, 7412.703491860481, 6293.402126797947, 6789.15135608049, 7184.425245980414, 7429.851402971803, 7499.812504687427, 6823.351781580742, 6854.074699915647, 6920.653967301514, 7009.0, 7064.2935706431, 6919.37725604698, 6948.722051117898, 7009.439244860297, 7019.929800702132, 7025.0, 6400.9374006990265, 6555.016747487915, 6602.570832895846, 6640.169978752656, 6643.634600097041, 6674.666266686743, 6694.397504224643, 6714.563553369211, 6725.159355080615, 6741.865162696817], "unit": "score", "name": "mootools.html", "value": 4564.078016777084}, {"lowerIsBetter": false, "replicates": [339.45517444501576, 349.80410969856877, 350.2102758280078, 357.06983308481387, 359.75356880536833, 6252.155958945541, 6286.968565157168, 6337.778177763774, 6387.361263873616, 6487.253965793935, 6298.748050078003, 6337.746490140389, 6351.364863513646, 6356.809295721136, 6380.202474690664, 4821.614270858323, 4830.082284365977, 4835.226363781796, 4835.443923948747, 4844.467108618049, 4836.927446088294, 4839.05638400512, 4842.29786680931, 4845.297431872376, 4855.6115510759055, 4727.432708075035, 4813.711177329354, 4816.422029356465, 4820.662553621248, 4824.083424149418, 4793.113274044278, 4794.208955522335, 4795.448523419816, 4802.18362878308, 4808.0, 4180.728252663597, 4180.9338618652355, 4181.958180418218, 4192.4759405074365, 4197.349410841294, 5962.522998160137, 6048.243969503812, 6061.757529698807, 6068.787592434243, 6083.756649734005, 5599.1041433370465, 5630.887382252332, 5639.943600563983, 5646.0, 5646.04017317053, 6700.597964122168, 6711.261761206263, 6735.326467353275, 6736.393724564764, 6738.35985581369, 4649.302604609302, 4655.627549796042, 4658.95341046592, 4662.603678687282, 4674.672772905898, 6926.445884329241, 6973.686184121727, 6979.4765392595755, 7008.474364422637, 7023.227444981048, 4732.834350797705, 4735.337052812609, 4740.857774266778, 4749.643776716691, 4756.500567440438, 4796.760161991956, 4806.615470762331, 4816.710997340171, 4817.397825271841, 4831.879203019953, 5487.670739755547, 5546.362168350692, 5563.777448902079, 5566.805161819317, 5567.47109024642, 6678.465722742169, 6711.597304161766, 6734.696938637773, 6737.0, 6743.0, 1663.0271291294728, 1690.5182023123596, 1702.3445973300368, 1705.4883534939718, 1708.2910592104386, 1106.31961343773, 1117.9720506987228, 1118.2731224703846, 1129.836173754801, 1132.5016992523263, 6213.96893015532, 6219.098230756515, 6223.0, 6236.844078898064, 6243.157173781572, 6730.629815360202, 6784.966075169593, 6787.423069039187, 6799.456043516507, 6799.93200067993, 6018.3680713524445, 6161.106639537242, 6163.291221509584, 6198.0702894565275, 6240.7503699852405, 3679.1721862580707, 3704.1665625234646, 3704.3147017801793, 3706.184639379332, 3706.8887933362043, 7046.0, 7050.471214658921, 7059.92940070603, 7065.858682826315, 7086.2205157432645, 6779.796606101825, 6885.0, 6947.82630434233, 6963.4777391695825, 6965.860682786316, 7031.92968070323, 7051.612161331176, 7057.929420705727, 7076.32774886385, 7081.46888983318, 6751.493637977073, 6785.762498312535, 6799.014142949343, 6799.490038247251, 6800.081988931431, 6538.934610654022, 6700.2964688708935, 6714.462842972453, 6728.226253980855, 6734.831629209309, 7055.6824942876665, 7062.682179302046, 7078.716851326095, 7081.291870812877, 7092.716291348494, 4740.6444516660695, 4742.739149346819, 4745.762711864324, 4748.976255118702, 4764.237721964608, 6796.72813087471, 6804.489663275175, 6841.965790171017, 6842.349976752201, 6980.917957716562, 6808.93191068083, 6830.180378354629, 6833.624150671761, 6845.383915447434, 6860.279670634512, 6774.254831968578, 6794.946783248604, 6795.592264464148, 6810.897836532555, 6824.624645644339, 6536.182977127859, 6647.7008534617025, 6689.130413046273, 6694.163229596301, 6699.296573859675, 6677.165354330708, 6815.727370905108, 6831.89752153728, 6845.247022827584, 6855.07456493367, 6571.3757193066585, 6601.306862779339, 6602.240742314695, 6614.603123812587, 6652.301508341555], "unit": "score", "name": "prototype.html", "value": 5033.93736765054}, {"lowerIsBetter": false, "replicates": [666.7099811581962, 679.5175425447932, 709.1316866493277, 756.576317262333, 759.3317880265365, 12566.623001309952, 12587.181833180837, 12827.102102852792, 12838.80741788874, 12993.285369304684, 12017.339046352447, 12027.759444811121, 12059.638210853667, 12074.939625301884, 12105.515779368836, 660.5376236634352, 669.7555392281806, 800.9439339246255, 812.0296245986063, 813.1096449387941, 818.5947955761906, 819.7253919936799, 820.0610301205116, 824.2993455562754, 824.8020475085996, 861.2291998661194, 861.6682577207757, 862.6463150108457, 863.080818927843, 863.3309185381316, 852.8933883264592, 853.1809462915609, 854.273867212864, 854.2952064546743, 854.5470900422786, 624.2415465209792, 628.5003422279299, 631.28664608992, 631.9304876463585, 633.8003528888431, 12043.879561204363, 12159.331236781973, 12188.451519681636, 12214.450349734283, 12241.571544995883, 11857.229280096852, 11990.340531270776, 12041.81937270933, 12069.93965030178, 12264.325462099581, 10147.492625368703, 10159.288849780518, 10234.641787537475, 10370.274080814346, 10625.521851516623, 3564.821758912044, 3582.9967609069504, 3590.0665826885197, 3632.945505817415, 3637.5453068366455, 47677.0, 47922.281165782544, 48019.0, 48310.27534586984, 50499.24251136236, 9090.727278181665, 9146.451212927246, 9277.118673725985, 9366.29752768545, 9494.525273736286, 16661.50015499537, 16743.16284185786, 16920.661586768194, 16925.661486770197, 16953.745693814602, 6938.749136384148, 7031.929680703128, 7092.255313192144, 7184.568925864361, 7405.7778266652085, 4269.402283680287, 4289.206496798102, 4318.093200427883, 4323.437953066082, 4360.694751367438, 2979.642442906865, 2997.1757766614355, 2999.085278989929, 3002.0, 3019.788614796987, 549.884524249912, 571.4571157400486, 572.0047118014625, 576.5301279457229, 579.9768009279666, 528.4926470588279, 529.4890430734359, 610.487190759764, 615.8983767678283, 656.0814859197067, 7906.920930790733, 7997.800054998555, 8107.351411887035, 8157.347412207009, 8506.106858779738, 501.86951392637445, 609.2171559545963, 612.2469362683923, 614.7663887722637, 630.3475902440952, 3749.6250374962833, 3915.334393153171, 3947.624975627311, 4118.91762164755, 4147.668186545069, 49756.253656195186, 50256.24615630769, 50945.49054509481, 51100.0, 51134.0, 49077.50922490729, 49375.0, 50620.0, 51269.743651281504, 51288.74355628198, 42600.360994585106, 42812.143757125305, 43104.56895431005, 45952.3107153393, 46519.30221046687, 8234.794130146794, 8392.916070839457, 8486.830263394573, 8519.322020466176, 8843.778905527413, 34297.65702342945, 34466.65533344735, 35276.82361588176, 35345.823270883484, 35350.82324588361, 39300.410493843185, 40627.0, 43612.56387436212, 43803.561964381224, 43889.34165987577, 10820.67537973862, 11140.554377824796, 11170.385628790495, 11243.775124497628, 11372.545098196311, 10709.143268538654, 10968.177386696188, 11019.669409917715, 11178.944105279747, 11184.328940263611, 10646.946765266433, 10700.892991070301, 10715.732106697084, 10848.945755271488, 11286.943565282121, 11302.491387887729, 11337.09303255721, 11440.141989350666, 11657.591984280509, 11840.585579504675, 10272.948635256776, 10867.076298514714, 10868.0, 11074.833877491683, 11206.215564910379, 9214.308926830381, 9222.723318300461, 9391.671291504765, 9528.85706714386, 9560.808783824423, 8919.643214271357, 9046.728598142066, 9147.176754092163, 9186.632534698538, 9736.75658108553], "unit": "score", "name": "yui.html", "value": 6071.419403093661}], "name": "dromaeo_css", "value": 6916.528223391767}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 113.0, 111.0, 110.0, 124.0, 113.0, 109.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 154.0, 159.0, 127.0, 159.0, 150.0, 131.0, 163.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 165.0, 165.0, 165.0, 167.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 75.0, 72.0, 75.0, 75.0, 140.0, 72.0, 71.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 97.0, 97.0, 97.0, 148.0, 96.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 66.0, 60.0, 58.0, 63.0, 60.0, 60.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 85.0, 83.0, 83.0, 81.0, 91.0, 91.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 116.0, 115.0, 124.0, 119.0, 118.0, 121.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [134.0, 149.0, 143.0, 141.0, 149.0, 157.0, 149.0, 143.0, 141.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 71.0, 67.0, 66.0, 67.0, 67.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1506.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "DeltaBlue", "value": 352.2767040000001}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1059.322033898305], "unit": "score", "name": "RayTrace", "value": 698.549616}, {"lowerIsBetter": false, "replicates": [719.4244604316547], "unit": "score", "name": "Earley", "value": 926.3835699999998}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [40607.8431372549], "unit": "score", "name": "RegExp", "value": 22.43372042491549}, {"lowerIsBetter": false, "replicates": [626.5664160401003], "unit": "score", "name": "Splay", "value": 130.05963599999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20288.199815261512}]} 16:08:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20288.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1506.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6916.53"}}} 16:08:06 INFO - Return code: 0 16:08:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:08:06 INFO - # TBPL SUCCESS # 16:08:06 INFO - Running post-action listener: _resource_record_post_action 16:08:06 INFO - Running post-run listener: _resource_record_post_run 16:08:07 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 412291072; Read time: 0; Write time: 276452 16:08:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 96350208; Read time: 0; Write time: 62536 16:08:07 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 315940864; Read time: 0; Write time: 213916 16:08:07 INFO - Running post-run listener: _upload_blobber_files 16:08:07 INFO - Blob upload gear active. 16:08:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:08:07 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 16:08:07 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'] 16:08:07 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 16:08:07 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:08 INFO - (blobuploader) - INFO - Done attempting. 16:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:09 INFO - (blobuploader) - INFO - Done attempting. 16:08:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:08:09 INFO - Return code: 0 16:08:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:08:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:08:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad57335df1ec18f97dd202e795919eed0fb01d91d3aab6b7ef61367f30b69b0f4b621b660beee6ec25f0a63ae63e9beadad5e959fb25c9c554cb67207c4904d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39922b92b19c85e8e42906fb76063912036fd26c0573f3940bfe6d5e4f4ae6fdf579ee47ca7414db33e4849242d95d81d32bd5bf852660f03d0b251ac7227184"} 16:08:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:08:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:08:09 INFO - Contents: 16:08:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad57335df1ec18f97dd202e795919eed0fb01d91d3aab6b7ef61367f30b69b0f4b621b660beee6ec25f0a63ae63e9beadad5e959fb25c9c554cb67207c4904d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39922b92b19c85e8e42906fb76063912036fd26c0573f3940bfe6d5e4f4ae6fdf579ee47ca7414db33e4849242d95d81d32bd5bf852660f03d0b251ac7227184"} 16:08:09 INFO - Copying logs to upload dir... 16:08:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.156931 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-12 16:08:08.732877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 16:08:08.737240) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad57335df1ec18f97dd202e795919eed0fb01d91d3aab6b7ef61367f30b69b0f4b621b660beee6ec25f0a63ae63e9beadad5e959fb25c9c554cb67207c4904d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39922b92b19c85e8e42906fb76063912036fd26c0573f3940bfe6d5e4f4ae6fdf579ee47ca7414db33e4849242d95d81d32bd5bf852660f03d0b251ac7227184"} build_url:https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/DcQp3cB1TkWvO-zdcGI-xA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad57335df1ec18f97dd202e795919eed0fb01d91d3aab6b7ef61367f30b69b0f4b621b660beee6ec25f0a63ae63e9beadad5e959fb25c9c554cb67207c4904d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39922b92b19c85e8e42906fb76063912036fd26c0573f3940bfe6d5e4f4ae6fdf579ee47ca7414db33e4849242d95d81d32bd5bf852660f03d0b251ac7227184"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 16:08:08.762918) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:08:08.763306) ========= 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=0333a256a5e4f052382dd180000001b1-1452638750.146800-1086336128 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 16:08:08.848651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 16:08:08.848990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 16:08:08.849320) ========= ========= Total master_lag: 0.23 =========