builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1452231937.64 results: success (0) buildid: 20160107193106 builduid: 38b522f2dbb3461abfcb60ed64d3ba7a revision: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.642480) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.643512) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.643821) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004229 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.661274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.661601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.681889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.682181) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.731550) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.731850) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.732240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.732525) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 21:45:37-- 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% 210M=0s 2016-01-07 21:45:38 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179481 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.924195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:37.924505) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.151963 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.088008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.088380) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a7cc8b7aa556bd50c930f50770fa26661e41c03 --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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 21:45:38,260 truncating revision to first 12 chars 2016-01-07 21:45:38,260 Setting DEBUG logging. 2016-01-07 21:45:38,260 attempt 1/10 2016-01-07 21:45:38,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7cc8b7aa55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 21:45:38,486 unpacking tar archive at: mozilla-central-8a7cc8b7aa55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.492248 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.592919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.593223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.602664) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.602927) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 21:45:38.603359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2016-01-07 21:45:38.603639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:45:38 INFO - MultiFileLogger online at 20160107 21:45:38 in /builds/slave/test-pgo 21:45:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:45:38 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:45:38 INFO - {'append_to_log': False, 21:45:38 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:45:38 INFO - 'blob_upload_branch': 'Firefox', 21:45:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:45:38 INFO - 'branch': 'Firefox', 21:45:38 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:38 INFO - 'config_files': ('talos/linux_config.py',), 21:45:38 INFO - 'default_actions': ('clobber', 21:45:38 INFO - 'read-buildbot-config', 21:45:38 INFO - 'download-and-extract', 21:45:38 INFO - 'populate-webroot', 21:45:38 INFO - 'create-virtualenv', 21:45:38 INFO - 'install', 21:45:38 INFO - 'run-tests'), 21:45:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:38 INFO - 'download_minidump_stackwalk': True, 21:45:38 INFO - 'download_symbols': 'ondemand', 21:45:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:38 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:38 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:38 INFO - 'installer_path': 'installer.exe', 21:45:38 INFO - 'log_level': 'info', 21:45:38 INFO - 'log_name': 'talos', 21:45:38 INFO - 'log_to_console': True, 21:45:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:45:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:45:38 INFO - 'opt_config_files': (), 21:45:38 INFO - 'pip_index': False, 21:45:38 INFO - 'sps_profile': False, 21:45:38 INFO - 'sps_profile_interval': 0, 21:45:38 INFO - 'suite': 'dromaeojs', 21:45:38 INFO - 'system_bits': '32', 21:45:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:38 INFO - 'title': 'talos-linux64-ix-055', 21:45:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:38 INFO - 'use_talos_json': True, 21:45:38 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:45:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:38 INFO - 'work_dir': 'build'} 21:45:38 INFO - ##### 21:45:38 INFO - ##### Running clobber step. 21:45:38 INFO - ##### 21:45:38 INFO - Running pre-action listener: _resource_record_pre_action 21:45:38 INFO - Running main action method: clobber 21:45:38 INFO - rmtree: /builds/slave/test-pgo/build 21:45:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:45:39 INFO - Running post-action listener: _resource_record_post_action 21:45:39 INFO - ##### 21:45:39 INFO - ##### Running read-buildbot-config step. 21:45:39 INFO - ##### 21:45:39 INFO - Running pre-action listener: _resource_record_pre_action 21:45:39 INFO - Running main action method: read_buildbot_config 21:45:39 INFO - Using buildbot properties: 21:45:39 INFO - { 21:45:39 INFO - "project": "", 21:45:39 INFO - "product": "firefox", 21:45:39 INFO - "script_repo_revision": "production", 21:45:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:45:39 INFO - "repository": "", 21:45:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:45:39 INFO - "buildid": "20160107193106", 21:45:39 INFO - "pgo_build": "True", 21:45:39 INFO - "basedir": "/builds/slave/test-pgo", 21:45:39 INFO - "buildnumber": 296, 21:45:39 INFO - "slavename": "talos-linux64-ix-055", 21:45:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:45:39 INFO - "platform": "ubuntu64_hw", 21:45:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:45:39 INFO - "branch": "mozilla-central", 21:45:39 INFO - "repo_path": "mozilla-central", 21:45:39 INFO - "revision": "8a7cc8b7aa556bd50c930f50770fa26661e41c03", 21:45:39 INFO - "stage_platform": "linux64-pgo", 21:45:39 INFO - "builduid": "38b522f2dbb3461abfcb60ed64d3ba7a", 21:45:39 INFO - "slavebuilddir": "test" 21:45:39 INFO - } 21:45:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:45:39 INFO - Running post-action listener: _resource_record_post_action 21:45:39 INFO - ##### 21:45:39 INFO - ##### Running download-and-extract step. 21:45:39 INFO - ##### 21:45:39 INFO - Running pre-action listener: _resource_record_pre_action 21:45:39 INFO - Running main action method: download_and_extract 21:45:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:45:39 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')]} 21:45:39 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json 21:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json 21:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:45:48 INFO - Downloaded 1302 bytes. 21:45:48 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:45:48 INFO - Using the following test package requirements: 21:45:48 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:48 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:45:48 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'jsshell-linux-x86_64.zip'], 21:45:48 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:45:48 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:48 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:45:48 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:45:48 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:45:48 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:48 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:48 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:45:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:48 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:54 INFO - Downloaded 24018155 bytes. 21:45:54 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 21:45:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:54 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 21:45:56 INFO - Return code: 0 21:45:56 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 21:45:56 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')]} 21:45:56 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:45:59 INFO - Downloaded 24018155 bytes. 21:45:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:45:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:46:00 INFO - Return code: 0 21:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:00 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:46:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:46:02 INFO - Downloaded 11132285 bytes. 21:46:02 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 21:46:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:46:02 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 21:46:02 INFO - Return code: 0 21:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:02 INFO - https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DS51ws91TmGqbNVb_AUFVA/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 21:46:04 INFO - Downloaded 55891965 bytes. 21:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:04 INFO - mkdir: /builds/slave/test-pgo/properties 21:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:46:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:46:04 INFO - Contents: 21:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:46:04 INFO - Running post-action listener: _resource_record_post_action 21:46:04 INFO - Running post-action listener: set_extra_try_arguments 21:46:04 INFO - ##### 21:46:04 INFO - ##### Running populate-webroot step. 21:46:04 INFO - ##### 21:46:04 INFO - Running pre-action listener: _resource_record_pre_action 21:46:04 INFO - Running main action method: populate_webroot 21:46:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:46:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:46:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:46:04 INFO - '--tppagecycles', 21:46:04 INFO - '7'], 21:46:04 INFO - 'tests': ['tsvgm']}}, 21:46:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:46:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:46:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:46:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:46:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:46:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'tests': ['damp', 'tps']}, 21:46:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['damp', 'tps']}, 21:46:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:46:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:46:04 INFO - 'other': {'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'other_l64': {'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'other_nol64': {'tests': ['a11yr', 21:46:04 INFO - 'ts_paint', 21:46:04 INFO - 'tpaint', 21:46:04 INFO - 'sessionrestore', 21:46:04 INFO - 'sessionrestore_no_auto_restore']}, 21:46:04 INFO - 'svgr': {'tests': ['tsvgx', 21:46:04 INFO - 'tsvgr_opacity', 21:46:04 INFO - 'tart', 21:46:04 INFO - 'tscrollx', 21:46:04 INFO - 'cart']}, 21:46:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['tsvgx', 21:46:04 INFO - 'tsvgr_opacity', 21:46:04 INFO - 'tart', 21:46:04 INFO - 'tscrollx', 21:46:04 INFO - 'cart']}, 21:46:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'tests': ['tp5o']}, 21:46:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'talos_options': ['--e10s'], 21:46:04 INFO - 'tests': ['tp5o']}, 21:46:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'talos_options': ['--xperf_path', 21:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:04 INFO - 'tests': ['tp5n']}, 21:46:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:46:04 INFO - 'talos_options': ['--e10s', 21:46:04 INFO - '--xperf_path', 21:46:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:46:04 INFO - 'tests': ['tp5n']}}, 21:46:04 INFO - 'talos.zip': {'path': '', 21:46:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:46:04 INFO - Running post-action listener: _resource_record_post_action 21:46:04 INFO - ##### 21:46:04 INFO - ##### Running create-virtualenv step. 21:46:04 INFO - ##### 21:46:04 INFO - Running pre-action listener: _resource_record_pre_action 21:46:04 INFO - Running main action method: create_virtualenv 21:46:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:46:04 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 21:46:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:46:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:46:04 INFO - Using real prefix '/usr' 21:46:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:46:05 INFO - Installing distribute.............................................................................................................................................................................................done. 21:46:06 INFO - Installing pip.................done. 21:46:06 INFO - Return code: 0 21:46:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:46:06 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')]} 21:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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')]} 21:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:06 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 21:46:06 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 21:46:07 INFO - Using env: {'DISPLAY': ':0', 21:46:07 INFO - 'HOME': '/home/cltbld', 21:46:07 INFO - 'LANG': 'en_US.UTF-8', 21:46:07 INFO - 'LANGUAGE': 'en_US:en', 21:46:07 INFO - 'LOGNAME': 'cltbld', 21:46:07 INFO - 'MAIL': '/var/mail/cltbld', 21:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:07 INFO - 'MOZ_NO_REMOTE': '1', 21:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:07 INFO - 'NO_EM_RESTART': '1', 21:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:07 INFO - 'SHELL': '/bin/bash', 21:46:07 INFO - 'SHLVL': '1', 21:46:07 INFO - 'TERM': 'linux', 21:46:07 INFO - 'TMOUT': '86400', 21:46:07 INFO - 'USER': 'cltbld', 21:46:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:07 INFO - '_': '/tools/buildbot/bin/python'} 21:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:07 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 21:46:07 INFO - Cleaning up... 21:46:07 INFO - Return code: 0 21:46:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:07 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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:07 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 21:46:07 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 21:46:07 INFO - Using env: {'DISPLAY': ':0', 21:46:07 INFO - 'HOME': '/home/cltbld', 21:46:07 INFO - 'LANG': 'en_US.UTF-8', 21:46:07 INFO - 'LANGUAGE': 'en_US:en', 21:46:07 INFO - 'LOGNAME': 'cltbld', 21:46:07 INFO - 'MAIL': '/var/mail/cltbld', 21:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:07 INFO - 'MOZ_NO_REMOTE': '1', 21:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:07 INFO - 'NO_EM_RESTART': '1', 21:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:07 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:07 INFO - 'SHELL': '/bin/bash', 21:46:07 INFO - 'SHLVL': '1', 21:46:07 INFO - 'TERM': 'linux', 21:46:07 INFO - 'TMOUT': '86400', 21:46:07 INFO - 'USER': 'cltbld', 21:46:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:07 INFO - '_': '/tools/buildbot/bin/python'} 21:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:07 INFO - Downloading/unpacking psutil>=0.7.1 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:09 INFO - Installing collected packages: psutil 21:46:09 INFO - Running setup.py install for psutil 21:46:09 INFO - building 'psutil._psutil_linux' extension 21:46:09 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 21:46:09 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 21:46:09 INFO - building 'psutil._psutil_posix' extension 21:46:09 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 21:46:09 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 21:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:46:09 INFO - Successfully installed psutil 21:46:09 INFO - Cleaning up... 21:46:09 INFO - Return code: 0 21:46:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:46:09 INFO - Using env: {'DISPLAY': ':0', 21:46:09 INFO - 'HOME': '/home/cltbld', 21:46:09 INFO - 'LANG': 'en_US.UTF-8', 21:46:09 INFO - 'LANGUAGE': 'en_US:en', 21:46:09 INFO - 'LOGNAME': 'cltbld', 21:46:09 INFO - 'MAIL': '/var/mail/cltbld', 21:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:09 INFO - 'MOZ_NO_REMOTE': '1', 21:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:09 INFO - 'NO_EM_RESTART': '1', 21:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:09 INFO - 'SHELL': '/bin/bash', 21:46:09 INFO - 'SHLVL': '1', 21:46:09 INFO - 'TERM': 'linux', 21:46:09 INFO - 'TMOUT': '86400', 21:46:09 INFO - 'USER': 'cltbld', 21:46:09 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:09 INFO - '_': '/tools/buildbot/bin/python'} 21:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:46:11 INFO - Installing collected packages: mozsystemmonitor 21:46:11 INFO - Running setup.py install for mozsystemmonitor 21:46:11 INFO - Successfully installed mozsystemmonitor 21:46:11 INFO - Cleaning up... 21:46:11 INFO - Return code: 0 21:46:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:46:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:46:11 INFO - Using env: {'DISPLAY': ':0', 21:46:11 INFO - 'HOME': '/home/cltbld', 21:46:11 INFO - 'LANG': 'en_US.UTF-8', 21:46:11 INFO - 'LANGUAGE': 'en_US:en', 21:46:11 INFO - 'LOGNAME': 'cltbld', 21:46:11 INFO - 'MAIL': '/var/mail/cltbld', 21:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:11 INFO - 'MOZ_NO_REMOTE': '1', 21:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:11 INFO - 'NO_EM_RESTART': '1', 21:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:11 INFO - 'SHELL': '/bin/bash', 21:46:11 INFO - 'SHLVL': '1', 21:46:11 INFO - 'TERM': 'linux', 21:46:11 INFO - 'TMOUT': '86400', 21:46:11 INFO - 'USER': 'cltbld', 21:46:11 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:11 INFO - '_': '/tools/buildbot/bin/python'} 21:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:13 INFO - Downloading blobuploader-1.2.4.tar.gz 21:46:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:46:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:46:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:46:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:14 INFO - Downloading docopt-0.6.1.tar.gz 21:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:46:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:46:14 INFO - Running setup.py install for blobuploader 21:46:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:46:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:46:14 INFO - Running setup.py install for requests 21:46:14 INFO - Running setup.py install for docopt 21:46:15 INFO - Successfully installed blobuploader requests docopt 21:46:15 INFO - Cleaning up... 21:46:15 INFO - Return code: 0 21:46:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:15 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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:15 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 21:46:15 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 21:46:15 INFO - Using env: {'DISPLAY': ':0', 21:46:15 INFO - 'HOME': '/home/cltbld', 21:46:15 INFO - 'LANG': 'en_US.UTF-8', 21:46:15 INFO - 'LANGUAGE': 'en_US:en', 21:46:15 INFO - 'LOGNAME': 'cltbld', 21:46:15 INFO - 'MAIL': '/var/mail/cltbld', 21:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:15 INFO - 'MOZ_NO_REMOTE': '1', 21:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:15 INFO - 'NO_EM_RESTART': '1', 21:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:15 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:15 INFO - 'SHELL': '/bin/bash', 21:46:15 INFO - 'SHLVL': '1', 21:46:15 INFO - 'TERM': 'linux', 21:46:15 INFO - 'TMOUT': '86400', 21:46:15 INFO - 'USER': 'cltbld', 21:46:15 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:15 INFO - '_': '/tools/buildbot/bin/python'} 21:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:15 INFO - Running setup.py (path:/tmp/pip-2PfGlw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:15 INFO - Running setup.py (path:/tmp/pip-iz6uTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:15 INFO - Running setup.py (path:/tmp/pip-nTPX11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:15 INFO - Running setup.py (path:/tmp/pip-MFg2ZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:15 INFO - Running setup.py (path:/tmp/pip-vgbtMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:15 INFO - Running setup.py (path:/tmp/pip-u6Svr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:15 INFO - Running setup.py (path:/tmp/pip-UZrMwA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:15 INFO - Running setup.py (path:/tmp/pip-IkwFZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:15 INFO - Running setup.py (path:/tmp/pip-rCX6y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:15 INFO - Running setup.py (path:/tmp/pip-m6X5PC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:16 INFO - Running setup.py (path:/tmp/pip-HprlDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:16 INFO - Running setup.py (path:/tmp/pip-JWiLCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:16 INFO - Running setup.py (path:/tmp/pip-mDtNL3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:16 INFO - Running setup.py (path:/tmp/pip-2DwAhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:16 INFO - Running setup.py (path:/tmp/pip-Be8rUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:16 INFO - Running setup.py (path:/tmp/pip-XoFyid-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:16 INFO - Running setup.py (path:/tmp/pip-U7USRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:46:16 INFO - Running setup.py install for manifestparser 21:46:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:46:16 INFO - Running setup.py install for mozcrash 21:46:16 INFO - Running setup.py install for mozdebug 21:46:16 INFO - Running setup.py install for mozdevice 21:46:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:46:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:46:16 INFO - Running setup.py install for mozfile 21:46:17 INFO - Running setup.py install for mozhttpd 21:46:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozinfo 21:46:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozInstall 21:46:17 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozleak 21:46:17 INFO - Running setup.py install for mozlog 21:46:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for moznetwork 21:46:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozprocess 21:46:17 INFO - Running setup.py install for mozprofile 21:46:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozrunner 21:46:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:46:17 INFO - Running setup.py install for mozscreenshot 21:46:18 INFO - Running setup.py install for moztest 21:46:18 INFO - Running setup.py install for mozversion 21:46:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:46:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:46:18 INFO - Cleaning up... 21:46:18 INFO - Return code: 0 21:46:18 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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', '-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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:18 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 21:46:18 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 21:46:18 INFO - Using env: {'DISPLAY': ':0', 21:46:18 INFO - 'HOME': '/home/cltbld', 21:46:18 INFO - 'LANG': 'en_US.UTF-8', 21:46:18 INFO - 'LANGUAGE': 'en_US:en', 21:46:18 INFO - 'LOGNAME': 'cltbld', 21:46:18 INFO - 'MAIL': '/var/mail/cltbld', 21:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:18 INFO - 'MOZ_NO_REMOTE': '1', 21:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:18 INFO - 'NO_EM_RESTART': '1', 21:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:18 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:18 INFO - 'SHELL': '/bin/bash', 21:46:18 INFO - 'SHLVL': '1', 21:46:18 INFO - 'TERM': 'linux', 21:46:18 INFO - 'TMOUT': '86400', 21:46:18 INFO - 'USER': 'cltbld', 21:46:18 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:18 INFO - '_': '/tools/buildbot/bin/python'} 21:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:18 INFO - Running setup.py (path:/tmp/pip-r1gdnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:18 INFO - Running setup.py (path:/tmp/pip-tdEsqG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:18 INFO - Running setup.py (path:/tmp/pip-uu2j45-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:18 INFO - Running setup.py (path:/tmp/pip-VleOtu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:18 INFO - Running setup.py (path:/tmp/pip-QwzsyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:18 INFO - Running setup.py (path:/tmp/pip-jte1T2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:18 INFO - Running setup.py (path:/tmp/pip-hENmDU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:46:18 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)) 21:46:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:19 INFO - Running setup.py (path:/tmp/pip-VnFcd7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:19 INFO - Running setup.py (path:/tmp/pip-Sfye_g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:19 INFO - Running setup.py (path:/tmp/pip-GViACQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:19 INFO - Running setup.py (path:/tmp/pip-Hgn3Rp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:19 INFO - Running setup.py (path:/tmp/pip-n3NGhA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:19 INFO - Running setup.py (path:/tmp/pip-r_RS5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:19 INFO - Running setup.py (path:/tmp/pip-A_Tv32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:19 INFO - Running setup.py (path:/tmp/pip-738w0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:19 INFO - Running setup.py (path:/tmp/pip-XQ3XZS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:46:19 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)) 21:46:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:19 INFO - Running setup.py (path:/tmp/pip-6gSGEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:46:19 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)) 21:46:19 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)) 21:46:19 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)) 21:46:19 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)) 21:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:46:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:21 INFO - Downloading blessings-1.5.1.tar.gz 21:46:21 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 21:46:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:21 INFO - Installing collected packages: blessings 21:46:21 INFO - Running setup.py install for blessings 21:46:21 INFO - Successfully installed blessings 21:46:21 INFO - Cleaning up... 21:46:21 INFO - Return code: 0 21:46:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:46:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:21 INFO - Reading from file tmpfile_stdout 21:46:21 INFO - Current package versions: 21:46:21 INFO - argparse == 1.2.1 21:46:21 INFO - blessings == 1.5.1 21:46:21 INFO - blobuploader == 1.2.4 21:46:21 INFO - docopt == 0.6.1 21:46:21 INFO - manifestparser == 1.1 21:46:21 INFO - mozInstall == 1.12 21:46:21 INFO - mozcrash == 0.16 21:46:21 INFO - mozdebug == 0.1 21:46:21 INFO - mozdevice == 0.47 21:46:21 INFO - mozfile == 1.2 21:46:21 INFO - mozhttpd == 0.7 21:46:21 INFO - mozinfo == 0.9 21:46:21 INFO - mozleak == 0.1 21:46:21 INFO - mozlog == 3.1 21:46:21 INFO - moznetwork == 0.27 21:46:21 INFO - mozprocess == 0.22 21:46:21 INFO - mozprofile == 0.28 21:46:21 INFO - mozrunner == 6.11 21:46:21 INFO - mozscreenshot == 0.1 21:46:21 INFO - mozsystemmonitor == 0.0 21:46:21 INFO - moztest == 0.7 21:46:21 INFO - mozversion == 1.4 21:46:21 INFO - psutil == 3.1.1 21:46:21 INFO - requests == 1.2.3 21:46:21 INFO - wsgiref == 0.1.2 21:46:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46:21 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')]} 21:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:21 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')]} 21:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:21 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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:21 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 21:46:21 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 21:46:21 INFO - Using env: {'DISPLAY': ':0', 21:46:21 INFO - 'HOME': '/home/cltbld', 21:46:21 INFO - 'LANG': 'en_US.UTF-8', 21:46:21 INFO - 'LANGUAGE': 'en_US:en', 21:46:21 INFO - 'LOGNAME': 'cltbld', 21:46:21 INFO - 'MAIL': '/var/mail/cltbld', 21:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:21 INFO - 'MOZ_NO_REMOTE': '1', 21:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:21 INFO - 'NO_EM_RESTART': '1', 21:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:21 INFO - 'SHELL': '/bin/bash', 21:46:21 INFO - 'SHLVL': '1', 21:46:21 INFO - 'TERM': 'linux', 21:46:21 INFO - 'TMOUT': '86400', 21:46:21 INFO - 'USER': 'cltbld', 21:46:21 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:21 INFO - '_': '/tools/buildbot/bin/python'} 21:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 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)) 21:46:22 INFO - Cleaning up... 21:46:22 INFO - Return code: 0 21:46:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:46: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')]} 21:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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')]} 21:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46: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', 'jsonschema'] in /builds/slave/test-pgo/build 21:46: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 jsonschema 21:46:22 INFO - Using env: {'DISPLAY': ':0', 21:46:22 INFO - 'HOME': '/home/cltbld', 21:46:22 INFO - 'LANG': 'en_US.UTF-8', 21:46:22 INFO - 'LANGUAGE': 'en_US:en', 21:46:22 INFO - 'LOGNAME': 'cltbld', 21:46:22 INFO - 'MAIL': '/var/mail/cltbld', 21:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:22 INFO - 'MOZ_NO_REMOTE': '1', 21:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:22 INFO - 'NO_EM_RESTART': '1', 21:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:22 INFO - 'SHELL': '/bin/bash', 21:46:22 INFO - 'SHLVL': '1', 21:46:22 INFO - 'TERM': 'linux', 21:46:22 INFO - 'TMOUT': '86400', 21:46:22 INFO - 'USER': 'cltbld', 21:46:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:22 INFO - '_': '/tools/buildbot/bin/python'} 21:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:22 INFO - Downloading/unpacking jsonschema 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:22 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 21:46:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:24 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 21:46:24 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:24 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:46:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:24 INFO - warning: no files found matching '*.txt' 21:46:24 INFO - no previously-included directories found matching 'build' 21:46:24 INFO - no previously-included directories found matching 'dist' 21:46:24 INFO - no previously-included directories found matching '.git*' 21:46:24 INFO - Installing collected packages: jsonschema, functools32 21:46:24 INFO - Running setup.py install for functools32 21:46:24 INFO - warning: no files found matching '*.txt' 21:46:24 INFO - no previously-included directories found matching 'build' 21:46:24 INFO - no previously-included directories found matching 'dist' 21:46:24 INFO - no previously-included directories found matching '.git*' 21:46:24 INFO - Successfully installed jsonschema functools32 21:46:24 INFO - Cleaning up... 21:46:24 INFO - Return code: 0 21:46:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:46:24 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')]} 21:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:24 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')]} 21:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:24 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 0x7fb8031edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1803630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, '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': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', '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 21:46:24 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 21:46:24 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 21:46:24 INFO - Using env: {'DISPLAY': ':0', 21:46:24 INFO - 'HOME': '/home/cltbld', 21:46:24 INFO - 'LANG': 'en_US.UTF-8', 21:46:24 INFO - 'LANGUAGE': 'en_US:en', 21:46:24 INFO - 'LOGNAME': 'cltbld', 21:46:24 INFO - 'MAIL': '/var/mail/cltbld', 21:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:24 INFO - 'MOZ_NO_REMOTE': '1', 21:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:24 INFO - 'NO_EM_RESTART': '1', 21:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:24 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:24 INFO - 'SHELL': '/bin/bash', 21:46:24 INFO - 'SHLVL': '1', 21:46:24 INFO - 'TERM': 'linux', 21:46:24 INFO - 'TMOUT': '86400', 21:46:24 INFO - 'USER': 'cltbld', 21:46:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:24 INFO - '_': '/tools/buildbot/bin/python'} 21:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:24 INFO - Downloading/unpacking flake8 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:26 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 21:46:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:26 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 21:46:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 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 21:46:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:46:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:27 INFO - no previously-included directories found matching 'docs/_build' 21:46:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:27 INFO - Running setup.py install for pep8 21:46:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:27 INFO - no previously-included directories found matching 'docs/_build' 21:46:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:46:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:27 INFO - Cleaning up... 21:46:27 INFO - Return code: 0 21:46:27 INFO - Running post-action listener: _resource_record_post_action 21:46:27 INFO - Running post-action listener: _start_resource_monitoring 21:46:27 INFO - Starting resource monitoring. 21:46:27 INFO - ##### 21:46:27 INFO - ##### Running install step. 21:46:27 INFO - ##### 21:46:27 INFO - Running pre-action listener: _resource_record_pre_action 21:46:27 INFO - Running main action method: install 21:46:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:46:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:27 INFO - Reading from file tmpfile_stdout 21:46:27 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:46:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:46:27 INFO - Reading from file tmpfile_stdout 21:46:27 INFO - Output received: 21:46:27 INFO - Usage: mozinstall [options] installer 21:46:27 INFO - Options: 21:46:27 INFO - -h, --help show this help message and exit 21:46:27 INFO - -d DEST, --destination=DEST 21:46:27 INFO - Directory to install application into. [default: 21:46:27 INFO - "/builds/slave/test-pgo"] 21:46:27 INFO - --app=APP Application being installed. [default: firefox] 21:46:27 INFO - mkdir: /builds/slave/test-pgo/build/application 21:46:27 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'] 21:46:27 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 21:46:43 INFO - Reading from file tmpfile_stdout 21:46:43 INFO - Output received: 21:46:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:46:43 INFO - Running post-action listener: _resource_record_post_action 21:46:43 INFO - ##### 21:46:43 INFO - ##### Running run-tests step. 21:46:43 INFO - ##### 21:46:43 INFO - Running pre-action listener: _resource_record_pre_action 21:46:43 INFO - Running main action method: run_tests 21:46:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:46:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:46:43 INFO - Python 2.7.3 21:46:43 INFO - Return code: 0 21:46:43 INFO - grabbing minidump binary from tooltool 21:46:43 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')]} 21:46:43 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 0x1894840>, '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 0x18016b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1801b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:46:43 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 21:46:43 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 21:46:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:43 INFO - Return code: 0 21:46:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:46:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:46:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:46:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:46:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:46:44 INFO - Return code: 0 21:46:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:46:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:46:44 INFO - Using env: {'DISPLAY': ':0', 21:46:44 INFO - 'HOME': '/home/cltbld', 21:46:44 INFO - 'LANG': 'en_US.UTF-8', 21:46:44 INFO - 'LANGUAGE': 'en_US:en', 21:46:44 INFO - 'LOGNAME': 'cltbld', 21:46:44 INFO - 'MAIL': '/var/mail/cltbld', 21:46:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:44 INFO - 'MOZ_NO_REMOTE': '1', 21:46:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:44 INFO - 'NO_EM_RESTART': '1', 21:46:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:46:44 INFO - 'SHELL': '/bin/bash', 21:46:44 INFO - 'SHLVL': '1', 21:46:44 INFO - 'TERM': 'linux', 21:46:44 INFO - 'TMOUT': '86400', 21:46:44 INFO - 'USER': 'cltbld', 21:46:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572', 21:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:44 INFO - '_': '/tools/buildbot/bin/python'} 21:46:44 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:46:44 INFO - mozversion application_buildid: 20160107193106 21:46:44 INFO - mozversion application_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 21:46:44 INFO - mozversion application_display_name: Nightly 21:46:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:44 INFO - mozversion application_name: Firefox 21:46:44 INFO - mozversion application_remotingname: firefox 21:46:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:46:44 INFO - mozversion application_vendor: Mozilla 21:46:44 INFO - mozversion application_version: 46.0a1 21:46:44 INFO - mozversion platform_buildid: 20160107193106 21:46:44 INFO - mozversion platform_changeset: 8a7cc8b7aa556bd50c930f50770fa26661e41c03 21:46:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:46:44 INFO - mozversion platform_version: 46.0a1 21:46:44 INFO - using testdate: 1452232004 21:46:44 INFO - actual date: 1452232004 21:46:44 INFO - starting webserver on 'localhost:45330' 21:46:44 INFO - SUITE-START | Running 3 tests 21:46:44 INFO - TEST-START | dromaeo_css 21:46:44 INFO - operating with platform_type : linux_ 21:46:44 INFO - Initialising browser for dromaeo_css test... 21:46:44 INFO - TEST-INFO | started process 13296 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNUzMpV/profile http://localhost:45330/getInfo.html) 21:46:48 INFO - PROCESS | 13296 | __metrics Screen width/height:1600/1200 21:46:48 INFO - PROCESS | 13296 | colorDepth:24 21:46:48 INFO - PROCESS | 13296 | Browser inner width/height: 1024/697 21:46:48 INFO - PROCESS | 13296 | __metrics 21:46:48 INFO - PROCESS | 13296 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:46:48 INFO - PROCESS | 13296 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:46:49 INFO - TEST-INFO | 13296: exit 0 21:46:49 INFO - Browser initialized. 21:46:49 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:49 INFO - TEST-INFO | started process 13391 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNUzMpV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:01 INFO - PROCESS | 13391 | RSS: Main: 150511616 21:47:01 INFO - PROCESS | 13391 | 21:47:53 INFO - PROCESS | 13391 | 1452232073058 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] 21:50:01 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45330/tests/dromaeo/cssquery-ext.html) 21:50:02 INFO - PROCESS | 13391 | RSS: Main: 274165760 21:50:02 INFO - PROCESS | 13391 | 21:53:05 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-ext.html (next: http://localhost:45330/tests/dromaeo/cssquery-jquery.html) 21:53:05 INFO - PROCESS | 13391 | RSS: Main: 240996352 21:53:05 INFO - PROCESS | 13391 | 21:56:07 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45330/tests/dromaeo/cssquery-mootools.html) 21:56:08 INFO - PROCESS | 13391 | RSS: Main: 245960704 21:56:08 INFO - PROCESS | 13391 | 21:59:10 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45330/tests/dromaeo/cssquery-prototype.html) 21:59:10 INFO - PROCESS | 13391 | RSS: Main: 214364160 21:59:10 INFO - PROCESS | 13391 | 22:02:13 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45330/tests/dromaeo/cssquery-yui.html) 22:02:13 INFO - PROCESS | 13391 | RSS: Main: 218337280 22:02:13 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | Cycle 1(1): loaded http://localhost:45330/tests/dromaeo/cssquery-yui.html (next: http://localhost:45330/tests/dromaeo/cssquery-dojo.html) 22:05:16 INFO - PROCESS | 13391 | RSS: Main: 268267520 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | __start_tp_report 22:05:16 INFO - PROCESS | 13391 | _x_x_mozilla_page_load 22:05:16 INFO - PROCESS | 13391 | _x_x_mozilla_page_load_details 22:05:16 INFO - PROCESS | 13391 | |i|pagename|runs| 22:05:16 INFO - PROCESS | 13391 | |0;dojo.html;3064.371803780225;3126.7029632184936;3179.7297229735473;3183.2837611537393;3204.7596430267736;4879.853604391874;4974.776135073921;5029.497050294974;5057.26669632903;5116.616253780968;4990.575801056914;4996.125678006352;5068.645194836363;5071.797128114871;5090.567301779344;4397.31841564558;4576.130535198318;4614.976925115378;4688.835890743825;4725.013958682287;4467.15124126415;4564.657650676212;4657.743824089674;4658.720476771387;4781.995780886018;4543.159515489629;4622.976885115587;4639.118567472203;4651.1162879053045;4680.648951328664;4612.561806628399;4633.86098417048;4638.83764068256;4654.767261636905;4673.042026384583;4538.478075021382;4587.632989360876;4630.86107416778;4649.628029757611;4670.813167473297;4748.192807222746;4752.59602933751;4869.853904382874;4879.634027447955;4909.263610458424;5403.594730395197;5408.729563521808;5415.675059496403;5417.404085550586;5455.208994695787;5197.610179236573;5335.786568537293;5431.4840090191365;5433.347998240197;5433.918491222635;4978.352814134176;5014.197728363481;5046.470120637354;5050.191969284933;5091.847244582668;5524.502794748492;5562.666240025612;5569.192467092249;5572.3034620672415;5606.6916319602;5111.8722031948755;5213.296205012351;5216.321878155815;5370.489803468664;5434.592405569519;5221.582273418194;5354.330708661418;5355.410904800468;5358.356997160287;5378.220158077057;5294.258803767476;5319.38827034896;5324.307839980777;5331.760070796823;5374.167004114369;5222.294990176278;5247.1866860636665;5321.654092484054;5323.414424413311;5338.279332290169;4143.109231515178;4177.895552611149;4182.079942412664;4237.766922819213;4239.660827133822;3784.148566572499;3784.7729136251914;3788.090858194069;3800.923981520354;3819.52255968004;4822.71063736177;4919.975400123048;5032.6980381177245;5034.874128146826;5044;5326.813561525328;5389.865253368619;5414.945850541444;5422.186671999231;5453.127499600045;4990.975045124751;5016.44819069902;5023.867593222691;5024.472430394829;5047.697138171721;4449.510553839075;4549.385832912581;4558.133954548692;4617.676762626651;4639.211334073216;5478.041342765;5568.331800184003;5576.386597474275;5590.860228494239;5642.858928526737;5371.731413429391;5397.865053373697;5399.487048730364;5403;5415.458454154553;5453.2365468833605;5574.888502230014;5581.804636837854;5612.635178713371;5647.463490968352;5245.423003469692;5288.920666189933;5293.100172970528;5301.655392399482;5350.357957045024;5351.732413379237;5361.758720857492;5369.838904832861;5370.167624018283;5377.139657654757;5181.740912954413;5288.074586947346;5295.36455625312;5314.920276195938;5316.867078323073;5201.245819356248;5287.7620507078045;5295.470452954673;5298.549623282064;5344.225087362233;5201.92197117036;5216.269722238965;5252.395974462986;5255;5311.468853114658;5130.230465430215;5230.320058392384;5274.604404669589;5349.652272602269;5354.7858085676135;5129.410117836347;5250.606204534599;5255.474452554867;5255.947440525546;5297.17893726473 22:05:16 INFO - PROCESS | 13391 | |1;ext.html;535.6197100058961;551.68278240012;561.6573889927146;567.9062954612489;578.1760990588411;29895.252618684517;30569;30590.847045764767;30602.540961885534;30660.233494162658;31312.21719457015;31998.36003279933;36281.818590907074;37313.25373492528;37340.253194936085;8346.499210047417;8494.108118647515;8504.149585041509;8517.57412129391;8517.95741021294;7527.247275272456;8227;8373.706920257762;8392.748217553482;8403.5378054207;7590.392768578528;9925.404475731479;10144.949275253613;10158.187345012382;10173.287869849113;9746.97656746042;9845.606175752997;9919.454430006346;9920.40477571348;9936.304458687895;7501.137369202557;7699.730509432199;9758.853617195748;9785.510724463747;9896.208303335716;36327.63672363269;36726.26547469036;36742.44886326707;36769.816150919076;36900.630993689985;3068.47835867903;3093.2576181716227;3160.288934989609;3175.3649270145834;3613.1689711366535;28098.438031239464;28383.432331353462;28411;28609.427811443864;29086;3940.566537680853;3948.1116748731592;3987.1626958338784;3991.2815693175216;4028.274910516106;278727;279669.99999999796;280153;280263;280680;56925.43074569284;57182.13814342306;57222.42777572171;57226.141607875914;57236;58866.7056664714;58998;59050.40949590535;59122.408775912554;59479.40520594738;14599.270036498132;14800.851991480164;14825.258737063104;14836.629084272763;14838.258087095603;11168.106551475863;11277;11277.379744114152;11280.605178818867;11282.661520154408;17840.503051958563;18598.53503662419;18764.15561299745;18781.906090469733;18976.335828245945;6763.492738044666;6962.164540255202;7069.116360454943;7073.893891591631;7152.713891444284;870.7518357268148;927.7355953553205;986.6152200641756;989.6387818446216;1012.9696109116738;24973;25174.87412562962;28541.71458285432;29195.708042919723;29781.851090744407;974.9025097490194;977.4868194197961;993.7614972406715;1002.6490728245202;1079.3416016230094;13667.248301343323;13820.93089534566;13872.861271387157;13942.860571394156;14008.929955350159;332322;338520;339348;339371;340394;44395.89010274769;44994.325085123746;49297.26054109191;50389.74805125951;50483;1229.489761748882;1230.6246594788674;1244.296972210698;1288.1498211180576;1300.8829205371374;21655.783442165375;24892.253232403058;25571.23286301414;26234.08180713666;26296;41333.58666413418;41582;41639.16721665489;41651.7917410411;41783.582164179184;192388;192991;193011;193356;193628;29861.5520767193;30277.697223028368;30284.394312113192;31378.21554461157;31880;37197.25605487929;37663.62336376601;37922.62077379301;37988.430173547975;38142.046448839;33940.321193576485;34719.82640086783;34975.12562185965;35365.82317088398;36408.81795591111;32204.516932245566;32873.50689739608;32897.67102328946;34495.655043449246;35975.82012090027;31364.215894602818;31975.840120800178;32088.358232834744;32183;32208.83895580507;28450.715492844807;29539.556906645987;30026.549601755552;30177.849110754305;31468.685313146576;24054.639180412658;24086.759132408453;24121.276361709177;24326.026958921444;24481.75518244866 22:05:16 INFO - PROCESS | 13391 | |2;jquery.html;355.0874253169354;358.3084646631999;359.2599245554159;360.61594401961906;360.83040970743775;13390.531331403403;13809.723805523883;15993.760873477708;16398.754018689713;17515.64968700625;15343.923280383611;15475.69048619027;16598.087105209208;16610.086445245506;16610.66778664426;4979.975100124494;5378.193271009361;5378.489043540857;5380.112281473552;5381.112116500773;3935.842566297359;4090.6318431341174;5219.86950326243;5639.915401268964;5879.323877754049;5620.887582248352;5776.797812076578;5813.709314534256;5830.737616807232;5977.462028417442;5871.88256234875;5883.470487656089;5884.558658100616;5891.410858914117;5898.970505147468;4784.258439941815;4980.501949805027;4984.601231901439;4985.675931064469;5185.248139019821;12824.294663793487;14239.359228834728;19187.80812191874;19474.513137171543;19477.707834382494;1977.2881762565464;2037.8267847232855;2072.523319636477;2108.831293496532;2234.2068565659283;9156.542172891328;9404.670836520689;9413.529323533796;9746.561404736804;10103.84844227337;1820.626771511837;1821.307902996866;1849.1955999140416;1877.1552801239498;1895.2040143139914;54645.72677136629;54938;55992.44007559913;56131.43868561303;56712.43287567154;9321.161095501437;9463.526823658789;9545.761355966157;9587.616495340108;9637.614495420245;12268.570600028956;12281.877181228252;12298.508059677513;12301.32342721159;12320.137590368768;7025.367716905503;7134.108236470442;7159.391451726661;7184.353408193288;7212.350888420067;6901.75843845463;6902.689378977958;6941.062956500808;6956;6974.372306492339;3862.478565393636;4059.79701014954;4169.395437661522;4195.307774217281;4210.578942105765;1722.6305087455503;1742.8692848036449;1757.534253422844;1762.242235838576;1765.7086580714038;876.7939534209584;912.9452232866049;922.3589605224439;995.9393246192782;1009.9596016159418;14690.26548672562;15250.389984400721;15531.844681553266;15886.443974460839;16077.839221607868;890.7372325164092;906.5195446413411;906.8685040669199;940.0693313619604;978.3925837642745;9044.728658140266;9111.362204645611;9284.442933424016;9411.247100231965;9674.613015479303;492003;494731;520112;522390;522657;42886.78556607197;43508.12983740371;43551;68629.62740745157;71052.57894842178;1056.292284169593;1104.364990130678;1118.5358076398365;1122.4948773052158;1124.4265424633331;13734.93132534331;14696.485623003144;14751.704965900837;14906.850931490546;14912.850871491146;32320.030399088064;32468.35063298768;32512.187195320304;32907.67092329046;33369.666303337624;42160.78919605505;42172.36741448942;43790;44180.337294939956;46497.07005859932;6949.7567585134275;7099.964500177466;7100.502964792415;7232.336562590739;7246.094238220223;10184.134348580454;10249.872514023302;10813.945930270298;10913.508892100033;11233.606823761129;7139.535930164523;8383.496990180609;8501.702440414556;9192.908070919206;9434.339596228197;9145.314101442551;9378.859317110113;9395.718128456158;9441.386309889835;9627.229821614394;7468.5145465544565;9143.542822858697;9624.807503850025;9647.705637604655;9970.551325190529;7279.490435669452;7356.632168391666;7361;7368.1526624438875;7482.2517748224745;9342.205912497513;9807.656732014346;9984.950075249577;10003.099721025143;10098.8485172721 22:05:16 INFO - PROCESS | 13391 | |3;mootools.html;1316.7300703355813;1426.8073810035646;1438.4030627289671;1533.9463118790845;1683.5959369751263;6460.127882735829;6856.657167141641;6950.270221626726;6951.721931122762;6957.234704182549;6933.826654333644;7058.611776352299;7070.186928503211;7074.540154889929;7083.964580177105;1959.1477707197414;1996.3611644273838;2181.236567201475;2245.348848833836;2268.432891777056;2202.9779702203014;2207.7019602353716;2211.07135003299;2212.811910987568;2213.225371120111;2146.8604540704882;2248.763879792623;2256.6727824465524;2263.7057182566246;2263.841531092824;2209.4697272654525;2210.5357874846222;2244.730632324115;2244.955100897981;2247.179779380531;2227.4765430123907;2229.9888500557395;2256.7291924968945;2271.341311019802;2275.5221403505284;7184.497085204038;7244.8551028979655;7257.745978890714;7258.3104605062435;7260.745873894389;4456.2201614717615;4578.816847326103;4580.106879158566;4581.908361832778;4584.88537786558;2996.4905965985836;3138.1213260287154;3165.3669266146862;3184.55416241724;3185.952210716841;980.1864452504404;1022.7954409118132;1024.129489933558;1064.6805958212506;1103.779244151173;9331.72004839856;9401.435913845191;9411.576479058458;9416.95291523538;9421.905780942172;3897.629725176104;4059.939100913489;4069.715119941635;4073.429719839225;4116.3619638955415;7809.765707028798;7943.841123177504;7957.681692732226;7966.800829979297;7971.521708697381;4532.093581283756;4556.270996640522;4558.042811009659;4559.908801823945;4562.954370456319;4180.3102488089735;4225.852095176654;4226.5773422657485;4229.154169166179;4230.2174097792;3171.5242713592684;3221.2108033531936;3361.9495707564406;3391.033555436689;3454.635419009477;1059.666205145392;1078.9946050269698;1083.7236504691252;1087.331291255872;1088.1077516436446;970.2383628851318;991.3159919655415;1095.3427943234155;1236.1841184817977;1239.0273635196509;6512.511561632897;6517.3808488193545;6704.02791595216;6711.6979735912;6712.697928593225;1069.7860427914447;1071.919606029551;1077.7036315013434;1081.875584307799;1113.154002957758;5004.174311238605;5016.147254966591;5037.345145131109;5041;5053.7220452875445;8286.8342633147;8468.957655211685;8527.70153044653;8733.126687331343;8741.30069594431;8367.95816020916;8571.571421428904;8587.527685977331;8595;8602.569871506399;6672.099266598947;6772.69522871472;6792.8301792454595;6855.931440685529;6865.759698410531;6483.124778155077;6498.090267362668;6526.347365263436;6547.639879806466;6580.407763301326;7710.730124445618;7749.961250193713;7848.411369147451;7882.448228624171;7891.960540197262;7789.5715735635085;7965.761027168963;8046.1149273578685;8082.151374105634;8086.5148091114725;6430.356964303533;6534.771283005072;6571.244306904576;6592.8351791205605;6627.635480048643;5968.76124954997;6241.375862413723;6531.738730450918;6553.0170474429215;6553.934460655332;6034;6073.453389194994;6217.533684973555;6257.342978987141;6300.369963003663;6079.452849243589;6145.617290688839;6149.44654981036;6213.5339849512375;6213.689315534296;6222.066689996536;6296.401841825019;6429.5499315049365;6459.063435801689;6474.449671777952;5980.940190598212;6015.819525414245;6021.87956240864;6023.096535519707;6038.275406951194;5901.085331773582;5931.377205393372;5940;5981.790637327673;5982.521398288213 22:05:16 INFO - PROCESS | 13391 | |4;prototype.html;338.3892074804976;338.6055245638831;342.3085367557534;348.362496631165;349.8425708431206;5785.5082318002915;5814.040683287258;5823.883522329551;5824.563157763174;5849.064149736043;5715.542756579474;5756.453136951994;5760.164776107462;5762.3949485304065;5803.506701930341;4515.887102822431;4530.093981203756;4530.954690453086;4534.251848445003;4534.38785763921;4311.417958575584;4455.8217671293105;4456.509783923766;4465.843695470659;4470.776461176944;4399.604035636792;4400.899775056236;4418.469783625969;4434.135343607998;4464.732116073046;4255.87232383029;4330;4350.129974005212;4459.643228541725;4470.195364834329;3866.284737323576;3886.203328317688;3887.2031233597045;3893.80530973453;3917.7257591968573;5537.418571050062;5546.611737178399;5547.583931205176;5552.555795536347;5557;4907;5000.0999820032375;5008.7996480140755;5106.897862042739;5194.3766747990485;6065.514758819284;6141;6222.533310001768;6239.095331176954;6240.937590624127;4452.755098469583;4455.554444555551;4455.8217671293105;4457.153140903218;4461.643068554507;6317.210348706411;6357;6402.871942561169;6432.581882177644;6449.806505804833;4571.9314210286875;4574;4575.17646823575;4580.267157254823;4582.0377720679035;4627.514111018362;4633.30500424939;4634.9536504634525;4644.465886423037;4646.558576935254;5239.29269548606;5248.081585722483;5252.185911183773;5257.395399529103;5263.710495922761;6069.180660610849;6185.628862268189;6226.097215903668;6231.189945307172;6232.127502149703;1603.8315976822498;1613.2417763651065;1613.9354425823071;1614.4510866305513;1615.0390517641983;1094.8686157661132;1106.9612563560397;1111.8499002634542;1114.6823155400673;1128.7968165730083;5845.766169353178;5846.883062338729;5855.063189889683;5857.26784151981;5861.853453663693;6296.748130074838;6310.4005119514495;6323.588966717149;6337.049442583557;6344.524160687874;5822.621529600562;5824.271966004249;5834.970825145847;5838.153467747153;5839.036558967808;3305.388503126881;3416.8120753358307;3418.4872269159823;3424.2466657335344;3424.4692072728767;6581.934180658228;6584.275729669828;6588.077669126326;6588.53880228389;6593.703283352261;6353.904691429632;6458.160439142881;6488.708008139645;6499.025146228009;6500.089987401768;6501.577397469149;6675.198976122896;6679.833004174934;6691.933080669229;6698.765543205965;6394.520410969103;6400.647964362005;6402.35976402356;6406.967965160145;6408.871822563429;6176.567640265138;6298.716557755004;6360.236771587439;6364.64994425311;6384.61692298445;6687.996800479967;6699.732010719516;6701.32986701326;6704.7988560343265;6714.496412768965;4429;4471.396361491157;4477.619402350706;4477.843275485342;4483;6199.5040396767245;6444.516661250519;6453.870922581428;6454.612723236621;6455.386738259858;6270.965290726979;6286.371362863677;6287.779927702509;6287.779927702509;6297.149884765681;6236.03341482071;6279.654618995999;6283.59156654816;6283.874322513433;6288.9685551573775;6050.606710563799;6147.938520614736;6164.568480206342;6165.876682466415;6174.876502469836;6273.309935906956;6279.968600157153;6287;6300.432961033529;6349.8730025400155;6075.969620151871;6110.480609148272;6114.724837382418;6125.84685382869;6126.908096378647 22:05:16 INFO - PROCESS | 13391 | |5;yui.html;726.2084328082392;760.8021914302286;767.8118860879085;770.129753378682;778.2528772378516;13079.54221602244;13273.668158296023;13281;13288.468461261562;13316.533921312744;12541.366313074242;12571.748565028694;12621.810672839893;12648.49406023758;12669.429875655595;658.8682263547298;667.6995352091578;784.7488803582855;803.2289002557552;804.1998211779259;796.295278678368;796.3828033274201;801.7514570483169;801.7875263055295;801.8797180422924;701.7193122750889;703.9788806335819;833.7207035643066;835.9498430094184;836;812.9796755081111;831.2518733140192;831.3473922970439;832.0930186097153;832.4755404095381;608.8325710429623;610.2067312493784;610.2646311194999;610.5664977865721;610.6031079798122;12695.936520317431;13260.40328185234;13263.801042984363;13266.933665331708;13278.867211327859;12400.317982510958;12711.61865144038;12893.161944473579;12923.159994600415;12993.740125197442;10343;10406.687799366031;10414.27100102993;10703.518341674644;10864.511097000654;4305.095929854734;4368.737875727466;4509.075639493896;4516.074204788043;4522.140793249305;46984.295235571495;47356.526434735555;47671;47721.28418073697;48257;9289.489078100634;9396.48319342429;9547.52262386878;9565.091316324939;9933.056359645821;16863.325466981183;16928.830711692724;16967.66064678724;16986.405475808286;16992.57518562046;7228.927710722931;7470.813229669193;7579.090509138939;7585.317321441097;7770;4089.5501494835544;4254.510731265944;4258.850940217078;4260;4283.635890949305;2891.840948747797;2914.111196085172;2920.080174744991;2925.853707314626;2929.033418971734;536.0993530868179;547.3049227481076;550.1225545255311;550.6916126968911;553.4133818152771;571.9170720245625;603.6408337039454;675.152683382352;680.1158493957835;681.0839420978775;8345.791355216046;8895.911040889638;9408.247340212904;9507.619695212114;9529.952350238205;516.0581937963157;520.3651545114953;582.4641329976347;641.9069234960905;680.5950459476603;3811.447340135665;3935.8622448214173;4064.8577299794365;4135.338345864708;4158.344651274265;54709.45290547043;54980;54992;55072.72463637656;55178.72410637921;46105.76947115243;47080;47451.28823067657;47866.52133478621;47951.76024119857;43115.353269700354;43907.78046109749;44025.339619905084;45029.32456013162;45157.77421112874;8117.959410202911;8270.669173233004;8395.580220989048;8489.95755021221;8523.105073967145;32280.515792262664;32288.192795180308;32865.50701739428;33030.5045424314;33070.17324566905;38421;38554.0361490965;40662.59337406588;42241.57758422376;42650;9142.588583513625;9320.161185493338;9914.652987145415;9973.850392244267;10150.847737284093;11985.22096063753;12121.454534546143;12253.142280040312;12296.20074695142;12877.098603097693;11235.213535052795;11505.597304094317;11642.70893227676;11875.643730688093;12275.2021118627;11247.550097996316;11333.943330283295;11689.181757277249;11723.179377443497;12049.457774400349;7310.78310578601;10599.205059620714;11138.94430527842;11801.35092569917;12097.637070887888;9232.861507077265;9246.904182649621;9458.43249405038;9732.75668108303;9732.951335243562;9605.903940960501;9683.9031609683;9719.611215551582;9741.610335586498;9770.267229957924 22:05:16 INFO - PROCESS | 13391 | __end_tp_report 22:05:16 INFO - PROCESS | 13391 | __start_cc_report 22:05:16 INFO - PROCESS | 13391 | _x_x_mozilla_cycle_collect,1051 22:05:16 INFO - PROCESS | 13391 | __end_cc_report 22:05:16 INFO - PROCESS | 13391 | __startTimestamp1452233116729__endTimestamp 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | ------- Summary: start ------- 22:05:16 INFO - PROCESS | 13391 | Number of tests: 6 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#0] dojo.html Cycles:165 Average:5007.06 Median:5213.30 stddev:527.28 (10.1%) stddev-sans-first:506.39 22:05:16 INFO - PROCESS | 13391 | Values: 3064.4 3126.7 3179.7 3183.3 3204.8 4879.9 4974.8 5029.5 5057.3 5116.6 4990.6 4996.1 5068.6 5071.8 5090.6 4397.3 4576.1 4615.0 4688.8 4725.0 4467.2 4564.7 4657.7 4658.7 4782.0 4543.2 4623.0 4639.1 4651.1 4680.6 4612.6 4633.9 4638.8 4654.8 4673.0 4538.5 4587.6 4630.9 4649.6 4670.8 4748.2 4752.6 4869.9 4879.6 4909.3 5403.6 5408.7 5415.7 5417.4 5455.2 5197.6 5335.8 5431.5 5433.3 5433.9 4978.4 5014.2 5046.5 5050.2 5091.8 5524.5 5562.7 5569.2 5572.3 5606.7 5111.9 5213.3 5216.3 5370.5 5434.6 5221.6 5354.3 5355.4 5358.4 5378.2 5294.3 5319.4 5324.3 5331.8 5374.2 5222.3 5247.2 5321.7 5323.4 5338.3 4143.1 4177.9 4182.1 4237.8 4239.7 3784.1 3784.8 3788.1 3800.9 3819.5 4822.7 4920.0 5032.7 5034.9 5044.0 5326.8 5389.9 5414.9 5422.2 5453.1 4991.0 5016.4 5023.9 5024.5 5047.7 4449.5 4549.4 4558.1 4617.7 4639.2 5478.0 5568.3 5576.4 5590.9 5642.9 5371.7 5397.9 5399.5 5403.0 5415.5 5453.2 5574.9 5581.8 5612.6 5647.5 5245.4 5288.9 5293.1 5301.7 5350.4 5351.7 5361.8 5369.8 5370.2 5377.1 5181.7 5288.1 5295.4 5314.9 5316.9 5201.2 5287.8 5295.5 5298.5 5344.2 5201.9 5216.3 5252.4 5255.0 5311.5 5130.2 5230.3 5274.6 5349.7 5354.8 5129.4 5250.6 5255.5 5255.9 5297.2 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#1] ext.html Cycles:180 Average:42907.35 Median:335421.00 stddev:72601.16 (21.6%) stddev-sans-first:72735.12 22:05:16 INFO - PROCESS | 13391 | Values: 535.6 551.7 561.7 567.9 578.2 29895.3 30569.0 30590.8 30602.5 30660.2 31312.2 31998.4 36281.8 37313.3 37340.3 8346.5 8494.1 8504.1 8517.6 8518.0 7527.2 8227.0 8373.7 8392.7 8403.5 7590.4 9925.4 10144.9 10158.2 10173.3 9747.0 9845.6 9919.5 9920.4 9936.3 7501.1 7699.7 9758.9 9785.5 9896.2 36327.6 36726.3 36742.4 36769.8 36900.6 3068.5 3093.3 3160.3 3175.4 3613.2 28098.4 28383.4 28411.0 28609.4 29086.0 3940.6 3948.1 3987.2 3991.3 4028.3 278727.0 279670.0 280153.0 280263.0 280680.0 56925.4 57182.1 57222.4 57226.1 57236.0 58866.7 58998.0 59050.4 59122.4 59479.4 14599.3 14800.9 14825.3 14836.6 14838.3 11168.1 11277.0 11277.4 11280.6 11282.7 17840.5 18598.5 18764.2 18781.9 18976.3 6763.5 6962.2 7069.1 7073.9 7152.7 870.8 927.7 986.6 989.6 1013.0 24973.0 25174.9 28541.7 29195.7 29781.9 974.9 977.5 993.8 1002.6 1079.3 13667.2 13820.9 13872.9 13942.9 14008.9 332322.0 338520.0 339348.0 339371.0 340394.0 44395.9 44994.3 49297.3 50389.7 50483.0 1229.5 1230.6 1244.3 1288.1 1300.9 21655.8 24892.3 25571.2 26234.1 26296.0 41333.6 41582.0 41639.2 41651.8 41783.6 192388.0 192991.0 193011.0 193356.0 193628.0 29861.6 30277.7 30284.4 31378.2 31880.0 37197.3 37663.6 37922.6 37988.4 38142.0 33940.3 34719.8 34975.1 35365.8 36408.8 32204.5 32873.5 32897.7 34495.7 35975.8 31364.2 31975.8 32088.4 32183.0 32208.8 28450.7 29539.6 30026.5 30177.8 31468.7 24054.6 24086.8 24121.3 24326.0 24481.8 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#2] jquery.html Cycles:180 Average:25890.66 Median:5085.46 stddev:83269.10 (1637.4%) stddev-sans-first:83480.62 22:05:16 INFO - PROCESS | 13391 | Values: 355.1 358.3 359.3 360.6 360.8 13390.5 13809.7 15993.8 16398.8 17515.6 15343.9 15475.7 16598.1 16610.1 16610.7 4980.0 5378.2 5378.5 5380.1 5381.1 3935.8 4090.6 5219.9 5639.9 5879.3 5620.9 5776.8 5813.7 5830.7 5977.5 5871.9 5883.5 5884.6 5891.4 5899.0 4784.3 4980.5 4984.6 4985.7 5185.2 12824.3 14239.4 19187.8 19474.5 19477.7 1977.3 2037.8 2072.5 2108.8 2234.2 9156.5 9404.7 9413.5 9746.6 10103.8 1820.6 1821.3 1849.2 1877.2 1895.2 54645.7 54938.0 55992.4 56131.4 56712.4 9321.2 9463.5 9545.8 9587.6 9637.6 12268.6 12281.9 12298.5 12301.3 12320.1 7025.4 7134.1 7159.4 7184.4 7212.4 6901.8 6902.7 6941.1 6956.0 6974.4 3862.5 4059.8 4169.4 4195.3 4210.6 1722.6 1742.9 1757.5 1762.2 1765.7 876.8 912.9 922.4 995.9 1010.0 14690.3 15250.4 15531.8 15886.4 16077.8 890.7 906.5 906.9 940.1 978.4 9044.7 9111.4 9284.4 9411.2 9674.6 492003.0 494731.0 520112.0 522390.0 522657.0 42886.8 43508.1 43551.0 68629.6 71052.6 1056.3 1104.4 1118.5 1122.5 1124.4 13734.9 14696.5 14751.7 14906.9 14912.9 32320.0 32468.4 32512.2 32907.7 33369.7 42160.8 42172.4 43790.0 44180.3 46497.1 6949.8 7100.0 7100.5 7232.3 7246.1 10184.1 10249.9 10813.9 10913.5 11233.6 7139.5 8383.5 8501.7 9192.9 9434.3 9145.3 9378.9 9395.7 9441.4 9627.2 7468.5 9143.5 9624.8 9647.7 9970.6 7279.5 7356.6 7361.0 7368.2 7482.3 9342.2 9807.7 9985.0 10003.1 10098.8 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#3] mootools.html Cycles:180 Average:5016.85 Median:6022.49 stddev:2495.41 (41.4%) stddev-sans-first:2486.90 22:05:16 INFO - PROCESS | 13391 | Values: 1316.7 1426.8 1438.4 1533.9 1683.6 6460.1 6856.7 6950.3 6951.7 6957.2 6933.8 7058.6 7070.2 7074.5 7084.0 1959.1 1996.4 2181.2 2245.3 2268.4 2203.0 2207.7 2211.1 2212.8 2213.2 2146.9 2248.8 2256.7 2263.7 2263.8 2209.5 2210.5 2244.7 2245.0 2247.2 2227.5 2230.0 2256.7 2271.3 2275.5 7184.5 7244.9 7257.7 7258.3 7260.7 4456.2 4578.8 4580.1 4581.9 4584.9 2996.5 3138.1 3165.4 3184.6 3186.0 980.2 1022.8 1024.1 1064.7 1103.8 9331.7 9401.4 9411.6 9417.0 9421.9 3897.6 4059.9 4069.7 4073.4 4116.4 7809.8 7943.8 7957.7 7966.8 7971.5 4532.1 4556.3 4558.0 4559.9 4563.0 4180.3 4225.9 4226.6 4229.2 4230.2 3171.5 3221.2 3361.9 3391.0 3454.6 1059.7 1079.0 1083.7 1087.3 1088.1 970.2 991.3 1095.3 1236.2 1239.0 6512.5 6517.4 6704.0 6711.7 6712.7 1069.8 1071.9 1077.7 1081.9 1113.2 5004.2 5016.1 5037.3 5041.0 5053.7 8286.8 8469.0 8527.7 8733.1 8741.3 8368.0 8571.6 8587.5 8595.0 8602.6 6672.1 6772.7 6792.8 6855.9 6865.8 6483.1 6498.1 6526.3 6547.6 6580.4 7710.7 7750.0 7848.4 7882.4 7892.0 7789.6 7965.8 8046.1 8082.2 8086.5 6430.4 6534.8 6571.2 6592.8 6627.6 5968.8 6241.4 6531.7 6553.0 6553.9 6034.0 6073.5 6217.5 6257.3 6300.4 6079.5 6145.6 6149.4 6213.5 6213.7 6222.1 6296.4 6429.5 6459.1 6474.4 5980.9 6015.8 6021.9 6023.1 6038.3 5901.1 5931.4 5940.0 5981.8 5982.5 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#4] prototype.html Cycles:180 Average:5196.51 Median:5829.77 stddev:1548.80 (26.6%) stddev-sans-first:1509.61 22:05:16 INFO - PROCESS | 13391 | Values: 338.4 338.6 342.3 348.4 349.8 5785.5 5814.0 5823.9 5824.6 5849.1 5715.5 5756.5 5760.2 5762.4 5803.5 4515.9 4530.1 4531.0 4534.3 4534.4 4311.4 4455.8 4456.5 4465.8 4470.8 4399.6 4400.9 4418.5 4434.1 4464.7 4255.9 4330.0 4350.1 4459.6 4470.2 3866.3 3886.2 3887.2 3893.8 3917.7 5537.4 5546.6 5547.6 5552.6 5557.0 4907.0 5000.1 5008.8 5106.9 5194.4 6065.5 6141.0 6222.5 6239.1 6240.9 4452.8 4455.6 4455.8 4457.2 4461.6 6317.2 6357.0 6402.9 6432.6 6449.8 4571.9 4574.0 4575.2 4580.3 4582.0 4627.5 4633.3 4635.0 4644.5 4646.6 5239.3 5248.1 5252.2 5257.4 5263.7 6069.2 6185.6 6226.1 6231.2 6232.1 1603.8 1613.2 1613.9 1614.5 1615.0 1094.9 1107.0 1111.8 1114.7 1128.8 5845.8 5846.9 5855.1 5857.3 5861.9 6296.7 6310.4 6323.6 6337.0 6344.5 5822.6 5824.3 5835.0 5838.2 5839.0 3305.4 3416.8 3418.5 3424.2 3424.5 6581.9 6584.3 6588.1 6588.5 6593.7 6353.9 6458.2 6488.7 6499.0 6500.1 6501.6 6675.2 6679.8 6691.9 6698.8 6394.5 6400.6 6402.4 6407.0 6408.9 6176.6 6298.7 6360.2 6364.6 6384.6 6688.0 6699.7 6701.3 6704.8 6714.5 4429.0 4471.4 4477.6 4477.8 4483.0 6199.5 6444.5 6453.9 6454.6 6455.4 6271.0 6286.4 6287.8 6287.8 6297.1 6236.0 6279.7 6283.6 6283.9 6289.0 6050.6 6147.9 6164.6 6165.9 6174.9 6273.3 6280.0 6287.0 6300.4 6349.9 6076.0 6110.5 6114.7 6125.8 6126.9 22:05:16 INFO - PROCESS | 13391 | 22:05:16 INFO - PROCESS | 13391 | [#5] yui.html Cycles:180 Average:13283.52 Median:47696.14 stddev:15042.77 (31.5%) stddev-sans-first:15055.41 22:05:16 INFO - PROCESS | 13391 | Values: 726.2 760.8 767.8 770.1 778.3 13079.5 13273.7 13281.0 13288.5 13316.5 12541.4 12571.7 12621.8 12648.5 12669.4 658.9 667.7 784.7 803.2 804.2 796.3 796.4 801.8 801.8 801.9 701.7 704.0 833.7 835.9 836.0 813.0 831.3 831.3 832.1 832.5 608.8 610.2 610.3 610.6 610.6 12695.9 13260.4 13263.8 13266.9 13278.9 12400.3 12711.6 12893.2 12923.2 12993.7 10343.0 10406.7 10414.3 10703.5 10864.5 4305.1 4368.7 4509.1 4516.1 4522.1 46984.3 47356.5 47671.0 47721.3 48257.0 9289.5 9396.5 9547.5 9565.1 9933.1 16863.3 16928.8 16967.7 16986.4 16992.6 7228.9 7470.8 7579.1 7585.3 7770.0 4089.6 4254.5 4258.9 4260.0 4283.6 2891.8 2914.1 2920.1 2925.9 2929.0 536.1 547.3 550.1 550.7 553.4 571.9 603.6 675.2 680.1 681.1 8345.8 8895.9 9408.2 9507.6 9530.0 516.1 520.4 582.5 641.9 680.6 3811.4 3935.9 4064.9 4135.3 4158.3 54709.5 54980.0 54992.0 55072.7 55178.7 46105.8 47080.0 47451.3 47866.5 47951.8 43115.4 43907.8 44025.3 45029.3 45157.8 8118.0 8270.7 8395.6 8490.0 8523.1 32280.5 32288.2 32865.5 33030.5 33070.2 38421.0 38554.0 40662.6 42241.6 42650.0 9142.6 9320.2 9914.7 9973.9 10150.8 11985.2 12121.5 12253.1 12296.2 12877.1 11235.2 11505.6 11642.7 11875.6 12275.2 11247.6 11333.9 11689.2 11723.2 12049.5 7310.8 10599.2 11138.9 11801.4 12097.6 9232.9 9246.9 9458.4 9732.8 9733.0 9605.9 9683.9 9719.6 9741.6 9770.3 22:05:16 INFO - PROCESS | 13391 | -------- Summary: end -------- 22:05:16 INFO - PROCESS | 13391 | 22:05:17 INFO - TEST-INFO | 13391: exit 0 22:05:17 INFO - TEST-OK | dromaeo_css | took 1112478ms 22:05:17 INFO - TEST-START | kraken 22:05:17 INFO - operating with platform_type : linux_ 22:05:17 INFO - Initialising browser for kraken test... 22:05:17 INFO - TEST-INFO | started process 13581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqETiY/profile http://localhost:45330/getInfo.html) 22:05:21 INFO - PROCESS | 13581 | __metrics Screen width/height:1600/1200 22:05:21 INFO - PROCESS | 13581 | colorDepth:24 22:05:21 INFO - PROCESS | 13581 | Browser inner width/height: 1024/697 22:05:21 INFO - PROCESS | 13581 | __metrics 22:05:21 INFO - PROCESS | 13581 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:05:21 INFO - PROCESS | 13581 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:22 INFO - TEST-INFO | 13581: exit 0 22:05:22 INFO - Browser initialized. 22:05:22 INFO - Running cycle 1/1 for kraken test... 22:05:22 INFO - TEST-INFO | started process 13665 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiqETiY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:34 INFO - PROCESS | 13665 | RSS: Main: 150409216 22:05:34 INFO - PROCESS | 13665 | 22:05:36 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45330/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:37 INFO - PROCESS | 13665 | RSS: Main: 187011072 22:05:37 INFO - PROCESS | 13665 | 22:05:39 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45330/tests/kraken/driver.html?testName=audio-dft) 22:05:40 INFO - PROCESS | 13665 | RSS: Main: 178503680 22:05:40 INFO - PROCESS | 13665 | 22:05:43 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45330/tests/kraken/driver.html?testName=audio-fft) 22:05:43 INFO - PROCESS | 13665 | RSS: Main: 161099776 22:05:43 INFO - PROCESS | 13665 | 22:05:45 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45330/tests/kraken/driver.html?testName=audio-oscillator) 22:05:46 INFO - PROCESS | 13665 | RSS: Main: 164024320 22:05:46 INFO - PROCESS | 13665 | 22:05:48 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:49 INFO - PROCESS | 13665 | RSS: Main: 165666816 22:05:49 INFO - PROCESS | 13665 | 22:05:52 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45330/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:52 INFO - PROCESS | 13665 | RSS: Main: 166563840 22:05:52 INFO - PROCESS | 13665 | 22:05:55 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45330/tests/kraken/driver.html?testName=imaging-desaturate) 22:05:56 INFO - PROCESS | 13665 | RSS: Main: 167055360 22:05:56 INFO - PROCESS | 13665 | 22:05:59 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45330/tests/kraken/driver.html?testName=json-parse-financial) 22:05:59 INFO - PROCESS | 13665 | RSS: Main: 165625856 22:05:59 INFO - PROCESS | 13665 | 22:06:01 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:01 INFO - PROCESS | 13665 | RSS: Main: 177135616 22:06:01 INFO - PROCESS | 13665 | 22:06:03 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:04 INFO - PROCESS | 13665 | RSS: Main: 175235072 22:06:04 INFO - PROCESS | 13665 | 22:06:06 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:06 INFO - PROCESS | 13665 | RSS: Main: 187805696 22:06:06 INFO - PROCESS | 13665 | 22:06:09 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:09 INFO - PROCESS | 13665 | RSS: Main: 192978944 22:06:09 INFO - PROCESS | 13665 | 22:06:12 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:13 INFO - PROCESS | 13665 | RSS: Main: 190832640 22:06:13 INFO - PROCESS | 13665 | 22:06:14 INFO - PROCESS | 13665 | Cycle 1(1): loaded http://localhost:45330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45330/tests/kraken/driver.html?testName=ai-astar) 22:06:15 INFO - PROCESS | 13665 | RSS: Main: 249020416 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | __start_tp_report 22:06:15 INFO - PROCESS | 13665 | _x_x_mozilla_page_load 22:06:15 INFO - PROCESS | 13665 | _x_x_mozilla_page_load_details 22:06:15 INFO - PROCESS | 13665 | |i|pagename|runs| 22:06:15 INFO - PROCESS | 13665 | |0;ai-astar;111;111;104;111;110;111;100;110;110;111 22:06:15 INFO - PROCESS | 13665 | |1;audio-beat-detection;152;127;148;164;131;155;146;127;165;125 22:06:15 INFO - PROCESS | 13665 | |2;audio-dft;162;164;161;160;161;160;162;162;163;162 22:06:15 INFO - PROCESS | 13665 | |3;audio-fft;73;72;85;93;71;74;71;114;90;71 22:06:15 INFO - PROCESS | 13665 | |4;audio-oscillator;96;96;142;96;97;96;142;96;96;138 22:06:15 INFO - PROCESS | 13665 | |5;imaging-gaussian-blur;109;109;109;109;110;109;110;109;109;109 22:06:15 INFO - PROCESS | 13665 | |6;imaging-darkroom;146;145;146;145;146;145;146;145;145;146 22:06:15 INFO - PROCESS | 13665 | |7;imaging-desaturate;95;96;96;96;95;96;96;96;96;95 22:06:15 INFO - PROCESS | 13665 | |8;json-parse-financial;57;56;56;54;58;55;56;68;54;53 22:06:15 INFO - PROCESS | 13665 | |9;json-stringify-tinderbox;66;67;66;67;67;67;67;67;67;67 22:06:15 INFO - PROCESS | 13665 | |10;stanford-crypto-aes;92;85;84;85;85;85;84;85;86;85 22:06:15 INFO - PROCESS | 13665 | |11;stanford-crypto-ccm;116;117;130;114;122;114;116;124;116;122 22:06:15 INFO - PROCESS | 13665 | |12;stanford-crypto-pbkdf2;141;150;149;146;148;138;150;147;150;141 22:06:15 INFO - PROCESS | 13665 | |13;stanford-crypto-sha256-iterative;69;71;67;69;68;69;66;67;68;67 22:06:15 INFO - PROCESS | 13665 | __end_tp_report 22:06:15 INFO - PROCESS | 13665 | __start_cc_report 22:06:15 INFO - PROCESS | 13665 | _x_x_mozilla_cycle_collect,991 22:06:15 INFO - PROCESS | 13665 | __end_cc_report 22:06:15 INFO - PROCESS | 13665 | __startTimestamp1452233175029__endTimestamp 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | ------- Summary: start ------- 22:06:15 INFO - PROCESS | 13665 | Number of tests: 14 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:3.94 22:06:15 INFO - PROCESS | 13665 | Values: 111.0 111.0 104.0 111.0 110.0 111.0 100.0 110.0 110.0 111.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.00 stddev:15.47 (10.3%) stddev-sans-first:16.14 22:06:15 INFO - PROCESS | 13665 | Values: 152.0 127.0 148.0 164.0 131.0 155.0 146.0 127.0 165.0 125.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 22:06:15 INFO - PROCESS | 13665 | Values: 162.0 164.0 161.0 160.0 161.0 160.0 162.0 162.0 163.0 162.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:14.23 (19.4%) stddev-sans-first:14.76 22:06:15 INFO - PROCESS | 13665 | Values: 73.0 72.0 85.0 93.0 71.0 74.0 71.0 114.0 90.0 71.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:21.54 (22.4%) stddev-sans-first:22.28 22:06:15 INFO - PROCESS | 13665 | Values: 96.0 96.0 142.0 96.0 97.0 96.0 142.0 96.0 96.0 138.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:06:15 INFO - PROCESS | 13665 | Values: 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:06:15 INFO - PROCESS | 13665 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 22:06:15 INFO - PROCESS | 13665 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:4.24 (7.6%) stddev-sans-first:4.50 22:06:15 INFO - PROCESS | 13665 | Values: 57.0 56.0 56.0 54.0 58.0 55.0 56.0 68.0 54.0 53.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 22:06:15 INFO - PROCESS | 13665 | Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 67.0 67.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.32 (2.7%) stddev-sans-first:0.60 22:06:15 INFO - PROCESS | 13665 | Values: 92.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 86.0 85.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:119.50 stddev:5.22 (4.4%) stddev-sans-first:5.41 22:06:15 INFO - PROCESS | 13665 | Values: 116.0 117.0 130.0 114.0 122.0 114.0 116.0 124.0 116.0 122.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.50 stddev:4.42 (3.0%) stddev-sans-first:4.30 22:06:15 INFO - PROCESS | 13665 | Values: 141.0 150.0 149.0 146.0 148.0 138.0 150.0 147.0 150.0 141.0 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - PROCESS | 13665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.45 (2.1%) stddev-sans-first:1.50 22:06:15 INFO - PROCESS | 13665 | Values: 69.0 71.0 67.0 69.0 68.0 69.0 66.0 67.0 68.0 67.0 22:06:15 INFO - PROCESS | 13665 | -------- Summary: end -------- 22:06:15 INFO - PROCESS | 13665 | 22:06:15 INFO - TEST-INFO | 13665: exit 0 22:06:15 INFO - TEST-OK | kraken | took 58472ms 22:06:15 INFO - TEST-START | v8_7 22:06:15 INFO - operating with platform_type : linux_ 22:06:15 INFO - Initialising browser for v8_7 test... 22:06:15 INFO - TEST-INFO | started process 13912 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1SiUUB/profile http://localhost:45330/getInfo.html) 22:06:19 INFO - PROCESS | 13912 | __metrics Screen width/height:1600/1200 22:06:19 INFO - PROCESS | 13912 | colorDepth:24 22:06:19 INFO - PROCESS | 13912 | Browser inner width/height: 1024/697 22:06:19 INFO - PROCESS | 13912 | __metrics 22:06:19 INFO - PROCESS | 13912 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:06:19 INFO - PROCESS | 13912 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:06:20 INFO - TEST-INFO | 13912: exit 0 22:06:20 INFO - Browser initialized. 22:06:20 INFO - Running cycle 1/1 for v8_7 test... 22:06:20 INFO - TEST-INFO | started process 13991 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1SiUUB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:32 INFO - PROCESS | 13991 | RSS: Main: 149721088 22:06:32 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | Cycle 1(1): loaded http://localhost:45330/tests/v8_7/run.html (next: http://localhost:45330/tests/v8_7/run.html) 22:06:55 INFO - PROCESS | 13991 | RSS: Main: 614596608 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | __start_tp_report 22:06:55 INFO - PROCESS | 13991 | _x_x_mozilla_page_load 22:06:55 INFO - PROCESS | 13991 | _x_x_mozilla_page_load_details 22:06:55 INFO - PROCESS | 13991 | |i|pagename|runs| 22:06:55 INFO - PROCESS | 13991 | |0;Richards;169.63528413910095 22:06:55 INFO - PROCESS | 13991 | |1;DeltaBlue;190.2587519025875 22:06:55 INFO - PROCESS | 13991 | |2;Encrypt;279.87685418415896 22:06:55 INFO - PROCESS | 13991 | |3;Decrypt;5164.948453608247 22:06:55 INFO - PROCESS | 13991 | |4;RayTrace;1970.4724409448818 22:06:55 INFO - PROCESS | 13991 | |5;Earley;772.2007722007722 22:06:55 INFO - PROCESS | 13991 | |6;Boyer;12341.463414634147 22:06:55 INFO - PROCESS | 13991 | |7;RegExp;40900 22:06:55 INFO - PROCESS | 13991 | |8;Splay;624.6898263027296 22:06:55 INFO - PROCESS | 13991 | |9;NavierStokes;4840.579710144928 22:06:55 INFO - PROCESS | 13991 | __end_tp_report 22:06:55 INFO - PROCESS | 13991 | __startTimestamp1452233215248__endTimestamp 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | ------- Summary: start ------- 22:06:55 INFO - PROCESS | 13991 | Number of tests: 10 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#0] Richards Cycles:1 Average:169.64 Median:169.64 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 169.6 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#1] DeltaBlue Cycles:1 Average:190.26 Median:190.26 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 190.3 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 279.9 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 5164.9 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 1970.5 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#5] Earley Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 772.2 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 12341.5 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#7] RegExp Cycles:1 Average:40900.00 Median:40900.00 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 40900.0 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#8] Splay Cycles:1 Average:624.69 Median:624.69 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 624.7 22:06:55 INFO - PROCESS | 13991 | 22:06:55 INFO - PROCESS | 13991 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:06:55 INFO - PROCESS | 13991 | Values: 4840.6 22:06:55 INFO - PROCESS | 13991 | -------- Summary: end -------- 22:06:55 INFO - PROCESS | 13991 | 22:06:56 INFO - TEST-INFO | 13991: exit 0 22:06:56 INFO - TEST-OK | v8_7 | took 40187ms 22:06:56 INFO - SUITE-END | took 1211s 22:06:56 INFO - Completed test suite (00:20:11) 22:06:56 INFO - Working with test: dromaeo_css 22:06:56 INFO - Generating results file: dromaeo_css 22:06:56 INFO - Working with test: kraken 22:06:56 INFO - Generating results file: kraken 22:06:56 INFO - javascript benchmark 22:06:56 INFO - Working with test: v8_7 22:06:56 INFO - Generating results file: v8_7 22:06:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:06:56 INFO - process_Request line: dromaeo_css 6601.12 graph.html#tests=[[72,1,35]] 22:06:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:56 INFO - process_Request line: kraken 1498.20 graph.html#tests=[[232,1,35]] 22:06:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:56 INFO - process_Request line: v8_7 18902.13 graph.html#tests=[[230,1,35]] 22:06:56 INFO - RETURN: dromaeo_css: 6601.12 22:06:56 INFO - RETURN: kraken: 1498.20 22:06:56 INFO - RETURN: v8_7: 18902.13 22:06:56 INFO - javascript benchmark 22:06:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3064.371803780225, 3126.7029632184936, 3179.7297229735473, 3183.2837611537393, 3204.7596430267736, 4879.853604391874, 4974.776135073921, 5029.497050294974, 5057.26669632903, 5116.616253780968, 4990.575801056914, 4996.125678006352, 5068.645194836363, 5071.797128114871, 5090.567301779344, 4397.31841564558, 4576.130535198318, 4614.976925115378, 4688.835890743825, 4725.013958682287, 4467.15124126415, 4564.657650676212, 4657.743824089674, 4658.720476771387, 4781.995780886018, 4543.159515489629, 4622.976885115587, 4639.118567472203, 4651.1162879053045, 4680.648951328664, 4612.561806628399, 4633.86098417048, 4638.83764068256, 4654.767261636905, 4673.042026384583, 4538.478075021382, 4587.632989360876, 4630.86107416778, 4649.628029757611, 4670.813167473297, 4748.192807222746, 4752.59602933751, 4869.853904382874, 4879.634027447955, 4909.263610458424, 5403.594730395197, 5408.729563521808, 5415.675059496403, 5417.404085550586, 5455.208994695787, 5197.610179236573, 5335.786568537293, 5431.4840090191365, 5433.347998240197, 5433.918491222635, 4978.352814134176, 5014.197728363481, 5046.470120637354, 5050.191969284933, 5091.847244582668, 5524.502794748492, 5562.666240025612, 5569.192467092249, 5572.3034620672415, 5606.6916319602, 5111.8722031948755, 5213.296205012351, 5216.321878155815, 5370.489803468664, 5434.592405569519, 5221.582273418194, 5354.330708661418, 5355.410904800468, 5358.356997160287, 5378.220158077057, 5294.258803767476, 5319.38827034896, 5324.307839980777, 5331.760070796823, 5374.167004114369, 5222.294990176278, 5247.1866860636665, 5321.654092484054, 5323.414424413311, 5338.279332290169, 4143.109231515178, 4177.895552611149, 4182.079942412664, 4237.766922819213, 4239.660827133822, 3784.148566572499, 3784.7729136251914, 3788.090858194069, 3800.923981520354, 3819.52255968004, 4822.71063736177, 4919.975400123048, 5032.6980381177245, 5034.874128146826, 5044.0, 5326.813561525328, 5389.865253368619, 5414.945850541444, 5422.186671999231, 5453.127499600045, 4990.975045124751, 5016.44819069902, 5023.867593222691, 5024.472430394829, 5047.697138171721, 4449.510553839075, 4549.385832912581, 4558.133954548692, 4617.676762626651, 4639.211334073216, 5478.041342765, 5568.331800184003, 5576.386597474275, 5590.860228494239, 5642.858928526737, 5371.731413429391, 5397.865053373697, 5399.487048730364, 5403.0, 5415.458454154553, 5453.2365468833605, 5574.888502230014, 5581.804636837854, 5612.635178713371, 5647.463490968352, 5245.423003469692, 5288.920666189933, 5293.100172970528, 5301.655392399482, 5350.357957045024, 5351.732413379237, 5361.758720857492, 5369.838904832861, 5370.167624018283, 5377.139657654757, 5181.740912954413, 5288.074586947346, 5295.36455625312, 5314.920276195938, 5316.867078323073, 5201.245819356248, 5287.7620507078045, 5295.470452954673, 5298.549623282064, 5344.225087362233, 5201.92197117036, 5216.269722238965, 5252.395974462986, 5255.0, 5311.468853114658, 5130.230465430215, 5230.320058392384, 5274.604404669589, 5349.652272602269, 5354.7858085676135, 5129.410117836347, 5250.606204534599, 5255.474452554867, 5255.947440525546, 5297.17893726473], "unit": "score", "name": "dojo.html", "value": 4975.432275284411}, {"lowerIsBetter": false, "replicates": [535.6197100058961, 551.68278240012, 561.6573889927146, 567.9062954612489, 578.1760990588411, 29895.252618684517, 30569.0, 30590.847045764767, 30602.540961885534, 30660.233494162658, 31312.21719457015, 31998.36003279933, 36281.818590907074, 37313.25373492528, 37340.253194936085, 8346.499210047417, 8494.108118647515, 8504.149585041509, 8517.57412129391, 8517.95741021294, 7527.247275272456, 8227.0, 8373.706920257762, 8392.748217553482, 8403.5378054207, 7590.392768578528, 9925.404475731479, 10144.949275253613, 10158.187345012382, 10173.287869849113, 9746.97656746042, 9845.606175752997, 9919.454430006346, 9920.40477571348, 9936.304458687895, 7501.137369202557, 7699.730509432199, 9758.853617195748, 9785.510724463747, 9896.208303335716, 36327.63672363269, 36726.26547469036, 36742.44886326707, 36769.816150919076, 36900.630993689985, 3068.47835867903, 3093.2576181716227, 3160.288934989609, 3175.3649270145834, 3613.1689711366535, 28098.438031239464, 28383.432331353462, 28411.0, 28609.427811443864, 29086.0, 3940.566537680853, 3948.1116748731592, 3987.1626958338784, 3991.2815693175216, 4028.274910516106, 278727.0, 279669.99999999796, 280153.0, 280263.0, 280680.0, 56925.43074569284, 57182.13814342306, 57222.42777572171, 57226.141607875914, 57236.0, 58866.7056664714, 58998.0, 59050.40949590535, 59122.408775912554, 59479.40520594738, 14599.270036498132, 14800.851991480164, 14825.258737063104, 14836.629084272763, 14838.258087095603, 11168.106551475863, 11277.0, 11277.379744114152, 11280.605178818867, 11282.661520154408, 17840.503051958563, 18598.53503662419, 18764.15561299745, 18781.906090469733, 18976.335828245945, 6763.492738044666, 6962.164540255202, 7069.116360454943, 7073.893891591631, 7152.713891444284, 870.7518357268148, 927.7355953553205, 986.6152200641756, 989.6387818446216, 1012.9696109116738, 24973.0, 25174.87412562962, 28541.71458285432, 29195.708042919723, 29781.851090744407, 974.9025097490194, 977.4868194197961, 993.7614972406715, 1002.6490728245202, 1079.3416016230094, 13667.248301343323, 13820.93089534566, 13872.861271387157, 13942.860571394156, 14008.929955350159, 332322.0, 338520.0, 339348.0, 339371.0, 340394.0, 44395.89010274769, 44994.325085123746, 49297.26054109191, 50389.74805125951, 50483.0, 1229.489761748882, 1230.6246594788674, 1244.296972210698, 1288.1498211180576, 1300.8829205371374, 21655.783442165375, 24892.253232403058, 25571.23286301414, 26234.08180713666, 26296.0, 41333.58666413418, 41582.0, 41639.16721665489, 41651.7917410411, 41783.582164179184, 192388.0, 192991.0, 193011.0, 193356.0, 193628.0, 29861.5520767193, 30277.697223028368, 30284.394312113192, 31378.21554461157, 31880.0, 37197.25605487929, 37663.62336376601, 37922.62077379301, 37988.430173547975, 38142.046448839, 33940.321193576485, 34719.82640086783, 34975.12562185965, 35365.82317088398, 36408.81795591111, 32204.516932245566, 32873.50689739608, 32897.67102328946, 34495.655043449246, 35975.82012090027, 31364.215894602818, 31975.840120800178, 32088.358232834744, 32183.0, 32208.83895580507, 28450.715492844807, 29539.556906645987, 30026.549601755552, 30177.849110754305, 31468.685313146576, 24054.639180412658, 24086.759132408453, 24121.276361709177, 24326.026958921444, 24481.75518244866], "unit": "score", "name": "ext.html", "value": 17402.09324402366}, {"lowerIsBetter": false, "replicates": [355.0874253169354, 358.3084646631999, 359.2599245554159, 360.61594401961906, 360.83040970743775, 13390.531331403403, 13809.723805523883, 15993.760873477708, 16398.754018689713, 17515.64968700625, 15343.923280383611, 15475.69048619027, 16598.087105209208, 16610.086445245506, 16610.66778664426, 4979.975100124494, 5378.193271009361, 5378.489043540857, 5380.112281473552, 5381.112116500773, 3935.842566297359, 4090.6318431341174, 5219.86950326243, 5639.915401268964, 5879.323877754049, 5620.887582248352, 5776.797812076578, 5813.709314534256, 5830.737616807232, 5977.462028417442, 5871.88256234875, 5883.470487656089, 5884.558658100616, 5891.410858914117, 5898.970505147468, 4784.258439941815, 4980.501949805027, 4984.601231901439, 4985.675931064469, 5185.248139019821, 12824.294663793487, 14239.359228834728, 19187.80812191874, 19474.513137171543, 19477.707834382494, 1977.2881762565464, 2037.8267847232855, 2072.523319636477, 2108.831293496532, 2234.2068565659283, 9156.542172891328, 9404.670836520689, 9413.529323533796, 9746.561404736804, 10103.84844227337, 1820.626771511837, 1821.307902996866, 1849.1955999140416, 1877.1552801239498, 1895.2040143139914, 54645.72677136629, 54938.0, 55992.44007559913, 56131.43868561303, 56712.43287567154, 9321.161095501437, 9463.526823658789, 9545.761355966157, 9587.616495340108, 9637.614495420245, 12268.570600028956, 12281.877181228252, 12298.508059677513, 12301.32342721159, 12320.137590368768, 7025.367716905503, 7134.108236470442, 7159.391451726661, 7184.353408193288, 7212.350888420067, 6901.75843845463, 6902.689378977958, 6941.062956500808, 6956.0, 6974.372306492339, 3862.478565393636, 4059.79701014954, 4169.395437661522, 4195.307774217281, 4210.578942105765, 1722.6305087455503, 1742.8692848036449, 1757.534253422844, 1762.242235838576, 1765.7086580714038, 876.7939534209584, 912.9452232866049, 922.3589605224439, 995.9393246192782, 1009.9596016159418, 14690.26548672562, 15250.389984400721, 15531.844681553266, 15886.443974460839, 16077.839221607868, 890.7372325164092, 906.5195446413411, 906.8685040669199, 940.0693313619604, 978.3925837642745, 9044.728658140266, 9111.362204645611, 9284.442933424016, 9411.247100231965, 9674.613015479303, 492003.0, 494731.0, 520112.0, 522390.0, 522657.0, 42886.78556607197, 43508.12983740371, 43551.0, 68629.62740745157, 71052.57894842178, 1056.292284169593, 1104.364990130678, 1118.5358076398365, 1122.4948773052158, 1124.4265424633331, 13734.93132534331, 14696.485623003144, 14751.704965900837, 14906.850931490546, 14912.850871491146, 32320.030399088064, 32468.35063298768, 32512.187195320304, 32907.67092329046, 33369.666303337624, 42160.78919605505, 42172.36741448942, 43790.0, 44180.337294939956, 46497.07005859932, 6949.7567585134275, 7099.964500177466, 7100.502964792415, 7232.336562590739, 7246.094238220223, 10184.134348580454, 10249.872514023302, 10813.945930270298, 10913.508892100033, 11233.606823761129, 7139.535930164523, 8383.496990180609, 8501.702440414556, 9192.908070919206, 9434.339596228197, 9145.314101442551, 9378.859317110113, 9395.718128456158, 9441.386309889835, 9627.229821614394, 7468.5145465544565, 9143.542822858697, 9624.807503850025, 9647.705637604655, 9970.551325190529, 7279.490435669452, 7356.632168391666, 7361.0, 7368.1526624438875, 7482.2517748224745, 9342.205912497513, 9807.656732014346, 9984.950075249577, 10003.099721025143, 10098.8485172721], "unit": "score", "name": "jquery.html", "value": 7881.754573179828}, {"lowerIsBetter": false, "replicates": [1316.7300703355813, 1426.8073810035646, 1438.4030627289671, 1533.9463118790845, 1683.5959369751263, 6460.127882735829, 6856.657167141641, 6950.270221626726, 6951.721931122762, 6957.234704182549, 6933.826654333644, 7058.611776352299, 7070.186928503211, 7074.540154889929, 7083.964580177105, 1959.1477707197414, 1996.3611644273838, 2181.236567201475, 2245.348848833836, 2268.432891777056, 2202.9779702203014, 2207.7019602353716, 2211.07135003299, 2212.811910987568, 2213.225371120111, 2146.8604540704882, 2248.763879792623, 2256.6727824465524, 2263.7057182566246, 2263.841531092824, 2209.4697272654525, 2210.5357874846222, 2244.730632324115, 2244.955100897981, 2247.179779380531, 2227.4765430123907, 2229.9888500557395, 2256.7291924968945, 2271.341311019802, 2275.5221403505284, 7184.497085204038, 7244.8551028979655, 7257.745978890714, 7258.3104605062435, 7260.745873894389, 4456.2201614717615, 4578.816847326103, 4580.106879158566, 4581.908361832778, 4584.88537786558, 2996.4905965985836, 3138.1213260287154, 3165.3669266146862, 3184.55416241724, 3185.952210716841, 980.1864452504404, 1022.7954409118132, 1024.129489933558, 1064.6805958212506, 1103.779244151173, 9331.72004839856, 9401.435913845191, 9411.576479058458, 9416.95291523538, 9421.905780942172, 3897.629725176104, 4059.939100913489, 4069.715119941635, 4073.429719839225, 4116.3619638955415, 7809.765707028798, 7943.841123177504, 7957.681692732226, 7966.800829979297, 7971.521708697381, 4532.093581283756, 4556.270996640522, 4558.042811009659, 4559.908801823945, 4562.954370456319, 4180.3102488089735, 4225.852095176654, 4226.5773422657485, 4229.154169166179, 4230.2174097792, 3171.5242713592684, 3221.2108033531936, 3361.9495707564406, 3391.033555436689, 3454.635419009477, 1059.666205145392, 1078.9946050269698, 1083.7236504691252, 1087.331291255872, 1088.1077516436446, 970.2383628851318, 991.3159919655415, 1095.3427943234155, 1236.1841184817977, 1239.0273635196509, 6512.511561632897, 6517.3808488193545, 6704.02791595216, 6711.6979735912, 6712.697928593225, 1069.7860427914447, 1071.919606029551, 1077.7036315013434, 1081.875584307799, 1113.154002957758, 5004.174311238605, 5016.147254966591, 5037.345145131109, 5041.0, 5053.7220452875445, 8286.8342633147, 8468.957655211685, 8527.70153044653, 8733.126687331343, 8741.30069594431, 8367.95816020916, 8571.571421428904, 8587.527685977331, 8595.0, 8602.569871506399, 6672.099266598947, 6772.69522871472, 6792.8301792454595, 6855.931440685529, 6865.759698410531, 6483.124778155077, 6498.090267362668, 6526.347365263436, 6547.639879806466, 6580.407763301326, 7710.730124445618, 7749.961250193713, 7848.411369147451, 7882.448228624171, 7891.960540197262, 7789.5715735635085, 7965.761027168963, 8046.1149273578685, 8082.151374105634, 8086.5148091114725, 6430.356964303533, 6534.771283005072, 6571.244306904576, 6592.8351791205605, 6627.635480048643, 5968.76124954997, 6241.375862413723, 6531.738730450918, 6553.0170474429215, 6553.934460655332, 6034.0, 6073.453389194994, 6217.533684973555, 6257.342978987141, 6300.369963003663, 6079.452849243589, 6145.617290688839, 6149.44654981036, 6213.5339849512375, 6213.689315534296, 6222.066689996536, 6296.401841825019, 6429.5499315049365, 6459.063435801689, 6474.449671777952, 5980.940190598212, 6015.819525414245, 6021.87956240864, 6023.096535519707, 6038.275406951194, 5901.085331773582, 5931.377205393372, 5940.0, 5981.790637327673, 5982.521398288213], "unit": "score", "name": "mootools.html", "value": 4188.03984362606}, {"lowerIsBetter": false, "replicates": [338.3892074804976, 338.6055245638831, 342.3085367557534, 348.362496631165, 349.8425708431206, 5785.5082318002915, 5814.040683287258, 5823.883522329551, 5824.563157763174, 5849.064149736043, 5715.542756579474, 5756.453136951994, 5760.164776107462, 5762.3949485304065, 5803.506701930341, 4515.887102822431, 4530.093981203756, 4530.954690453086, 4534.251848445003, 4534.38785763921, 4311.417958575584, 4455.8217671293105, 4456.509783923766, 4465.843695470659, 4470.776461176944, 4399.604035636792, 4400.899775056236, 4418.469783625969, 4434.135343607998, 4464.732116073046, 4255.87232383029, 4330.0, 4350.129974005212, 4459.643228541725, 4470.195364834329, 3866.284737323576, 3886.203328317688, 3887.2031233597045, 3893.80530973453, 3917.7257591968573, 5537.418571050062, 5546.611737178399, 5547.583931205176, 5552.555795536347, 5557.0, 4907.0, 5000.0999820032375, 5008.7996480140755, 5106.897862042739, 5194.3766747990485, 6065.514758819284, 6141.0, 6222.533310001768, 6239.095331176954, 6240.937590624127, 4452.755098469583, 4455.554444555551, 4455.8217671293105, 4457.153140903218, 4461.643068554507, 6317.210348706411, 6357.0, 6402.871942561169, 6432.581882177644, 6449.806505804833, 4571.9314210286875, 4574.0, 4575.17646823575, 4580.267157254823, 4582.0377720679035, 4627.514111018362, 4633.30500424939, 4634.9536504634525, 4644.465886423037, 4646.558576935254, 5239.29269548606, 5248.081585722483, 5252.185911183773, 5257.395399529103, 5263.710495922761, 6069.180660610849, 6185.628862268189, 6226.097215903668, 6231.189945307172, 6232.127502149703, 1603.8315976822498, 1613.2417763651065, 1613.9354425823071, 1614.4510866305513, 1615.0390517641983, 1094.8686157661132, 1106.9612563560397, 1111.8499002634542, 1114.6823155400673, 1128.7968165730083, 5845.766169353178, 5846.883062338729, 5855.063189889683, 5857.26784151981, 5861.853453663693, 6296.748130074838, 6310.4005119514495, 6323.588966717149, 6337.049442583557, 6344.524160687874, 5822.621529600562, 5824.271966004249, 5834.970825145847, 5838.153467747153, 5839.036558967808, 3305.388503126881, 3416.8120753358307, 3418.4872269159823, 3424.2466657335344, 3424.4692072728767, 6581.934180658228, 6584.275729669828, 6588.077669126326, 6588.53880228389, 6593.703283352261, 6353.904691429632, 6458.160439142881, 6488.708008139645, 6499.025146228009, 6500.089987401768, 6501.577397469149, 6675.198976122896, 6679.833004174934, 6691.933080669229, 6698.765543205965, 6394.520410969103, 6400.647964362005, 6402.35976402356, 6406.967965160145, 6408.871822563429, 6176.567640265138, 6298.716557755004, 6360.236771587439, 6364.64994425311, 6384.61692298445, 6687.996800479967, 6699.732010719516, 6701.32986701326, 6704.7988560343265, 6714.496412768965, 4429.0, 4471.396361491157, 4477.619402350706, 4477.843275485342, 4483.0, 6199.5040396767245, 6444.516661250519, 6453.870922581428, 6454.612723236621, 6455.386738259858, 6270.965290726979, 6286.371362863677, 6287.779927702509, 6287.779927702509, 6297.149884765681, 6236.03341482071, 6279.654618995999, 6283.59156654816, 6283.874322513433, 6288.9685551573775, 6050.606710563799, 6147.938520614736, 6164.568480206342, 6165.876682466415, 6174.876502469836, 6273.309935906956, 6279.968600157153, 6287.0, 6300.432961033529, 6349.8730025400155, 6075.969620151871, 6110.480609148272, 6114.724837382418, 6125.84685382869, 6126.908096378647], "unit": "score", "name": "prototype.html", "value": 4702.016139027995}, {"lowerIsBetter": false, "replicates": [726.2084328082392, 760.8021914302286, 767.8118860879085, 770.129753378682, 778.2528772378516, 13079.54221602244, 13273.668158296023, 13281.0, 13288.468461261562, 13316.533921312744, 12541.366313074242, 12571.748565028694, 12621.810672839893, 12648.49406023758, 12669.429875655595, 658.8682263547298, 667.6995352091578, 784.7488803582855, 803.2289002557552, 804.1998211779259, 796.295278678368, 796.3828033274201, 801.7514570483169, 801.7875263055295, 801.8797180422924, 701.7193122750889, 703.9788806335819, 833.7207035643066, 835.9498430094184, 836.0, 812.9796755081111, 831.2518733140192, 831.3473922970439, 832.0930186097153, 832.4755404095381, 608.8325710429623, 610.2067312493784, 610.2646311194999, 610.5664977865721, 610.6031079798122, 12695.936520317431, 13260.40328185234, 13263.801042984363, 13266.933665331708, 13278.867211327859, 12400.317982510958, 12711.61865144038, 12893.161944473579, 12923.159994600415, 12993.740125197442, 10343.0, 10406.687799366031, 10414.27100102993, 10703.518341674644, 10864.511097000654, 4305.095929854734, 4368.737875727466, 4509.075639493896, 4516.074204788043, 4522.140793249305, 46984.295235571495, 47356.526434735555, 47671.0, 47721.28418073697, 48257.0, 9289.489078100634, 9396.48319342429, 9547.52262386878, 9565.091316324939, 9933.056359645821, 16863.325466981183, 16928.830711692724, 16967.66064678724, 16986.405475808286, 16992.57518562046, 7228.927710722931, 7470.813229669193, 7579.090509138939, 7585.317321441097, 7770.0, 4089.5501494835544, 4254.510731265944, 4258.850940217078, 4260.0, 4283.635890949305, 2891.840948747797, 2914.111196085172, 2920.080174744991, 2925.853707314626, 2929.033418971734, 536.0993530868179, 547.3049227481076, 550.1225545255311, 550.6916126968911, 553.4133818152771, 571.9170720245625, 603.6408337039454, 675.152683382352, 680.1158493957835, 681.0839420978775, 8345.791355216046, 8895.911040889638, 9408.247340212904, 9507.619695212114, 9529.952350238205, 516.0581937963157, 520.3651545114953, 582.4641329976347, 641.9069234960905, 680.5950459476603, 3811.447340135665, 3935.8622448214173, 4064.8577299794365, 4135.338345864708, 4158.344651274265, 54709.45290547043, 54980.0, 54992.0, 55072.72463637656, 55178.72410637921, 46105.76947115243, 47080.0, 47451.28823067657, 47866.52133478621, 47951.76024119857, 43115.353269700354, 43907.78046109749, 44025.339619905084, 45029.32456013162, 45157.77421112874, 8117.959410202911, 8270.669173233004, 8395.580220989048, 8489.95755021221, 8523.105073967145, 32280.515792262664, 32288.192795180308, 32865.50701739428, 33030.5045424314, 33070.17324566905, 38421.0, 38554.0361490965, 40662.59337406588, 42241.57758422376, 42650.0, 9142.588583513625, 9320.161185493338, 9914.652987145415, 9973.850392244267, 10150.847737284093, 11985.22096063753, 12121.454534546143, 12253.142280040312, 12296.20074695142, 12877.098603097693, 11235.213535052795, 11505.597304094317, 11642.70893227676, 11875.643730688093, 12275.2021118627, 11247.550097996316, 11333.943330283295, 11689.181757277249, 11723.179377443497, 12049.457774400349, 7310.78310578601, 10599.205059620714, 11138.94430527842, 11801.35092569917, 12097.637070887888, 9232.861507077265, 9246.904182649621, 9458.43249405038, 9732.75668108303, 9732.951335243562, 9605.903940960501, 9683.9031609683, 9719.611215551582, 9741.610335586498, 9770.267229957924], "unit": "score", "name": "yui.html", "value": 6156.26893731817}], "name": "dromaeo_css", "value": 6601.122916091746}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 104.0, 111.0, 110.0, 111.0, 100.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [152.0, 127.0, 148.0, 164.0, 131.0, 155.0, 146.0, 127.0, 165.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 160.0, 161.0, 160.0, 162.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 85.0, 93.0, 71.0, 74.0, 71.0, 114.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 96.0, 97.0, 96.0, 142.0, 96.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 54.0, 58.0, 55.0, 56.0, 68.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [92.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 130.0, 114.0, 122.0, 114.0, 116.0, 124.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 149.0, 146.0, 148.0, 138.0, 150.0, 147.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 67.0, 69.0, 68.0, 69.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1498.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.63528413910095], "unit": "score", "name": "Richards", "value": 208.10529000000002}, {"lowerIsBetter": false, "replicates": [190.2587519025875], "unit": "score", "name": "DeltaBlue", "value": 347.5162079999999}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [772.2007722007722], "unit": "score", "name": "Earley", "value": 863.0695849999998}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [40900.0], "unit": "score", "name": "RegExp", "value": 22.27347188264058}, {"lowerIsBetter": false, "replicates": [624.6898263027296], "unit": "score", "name": "Splay", "value": 130.4503396226415}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18902.12669444846}]} 22:06:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18902.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1498.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6601.12"}}} 22:06:56 INFO - Return code: 0 22:06:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:06:56 INFO - # TBPL SUCCESS # 22:06:56 INFO - Running post-action listener: _resource_record_post_action 22:06:56 INFO - Running post-run listener: _resource_record_post_run 22:06:57 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 40960; Write bytes: 556486656; Read time: 516; Write time: 555256 22:06:57 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 12288; Write bytes: 245911552; Read time: 356; Write time: 341492 22:06:57 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 28672; Write bytes: 310382592; Read time: 160; Write time: 213728 22:06:57 INFO - Running post-run listener: _upload_blobber_files 22:06:57 INFO - Blob upload gear active. 22:06:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:06:57 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 22:06:57 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:06:57 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:08:32 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:38 INFO - (blobuploader) - INFO - Done attempting. 22:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:38 INFO - (blobuploader) - INFO - Done attempting. 22:08:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:38 INFO - Return code: 0 22:08:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:08:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f0746d0482f83b4e864ff47264ba15400dcb66866f09ef2a06de3e2ded1a660ad300f0e8a8dc90cab48dbbd00e5e97a46957d7645a1ac6142fba30dd4d9ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc140e9ac4d949413025e4e6052985b26e8f4a16cce7f19fc08d79ad1c1bb004832384fd5bd3b1f44aef9d38dd1f1199f92da2737112a47f27879076884f90da"} 22:08:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:08:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:08:38 INFO - Contents: 22:08:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f0746d0482f83b4e864ff47264ba15400dcb66866f09ef2a06de3e2ded1a660ad300f0e8a8dc90cab48dbbd00e5e97a46957d7645a1ac6142fba30dd4d9ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc140e9ac4d949413025e4e6052985b26e8f4a16cce7f19fc08d79ad1c1bb004832384fd5bd3b1f44aef9d38dd1f1199f92da2737112a47f27879076884f90da"} 22:08:38 INFO - Copying logs to upload dir... 22:08:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1380.113012 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2016-01-07 22:08:38.724174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:38.727411) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f0746d0482f83b4e864ff47264ba15400dcb66866f09ef2a06de3e2ded1a660ad300f0e8a8dc90cab48dbbd00e5e97a46957d7645a1ac6142fba30dd4d9ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc140e9ac4d949413025e4e6052985b26e8f4a16cce7f19fc08d79ad1c1bb004832384fd5bd3b1f44aef9d38dd1f1199f92da2737112a47f27879076884f90da"} build_url:https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/DS51ws91TmGqbNVb_AUFVA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3f0746d0482f83b4e864ff47264ba15400dcb66866f09ef2a06de3e2ded1a660ad300f0e8a8dc90cab48dbbd00e5e97a46957d7645a1ac6142fba30dd4d9ebb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc140e9ac4d949413025e4e6052985b26e8f4a16cce7f19fc08d79ad1c1bb004832384fd5bd3b1f44aef9d38dd1f1199f92da2737112a47f27879076884f90da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:38.754597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:38.755035) ========= 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=82e07478c745e68b1fe4678a000001bc-1452231890.364610-450677572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 22:08:38.835801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 22:08:38.836153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 22:08:38.836485) ========= ========= Total master_lag: 0.19 =========