builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1453555815.56 results: success (0) buildid: 20160123030348 builduid: ba4172364f6c4da2befe2605e4704566 revision: 5f7c184ccd800b2ed512c23fb609007efd198eaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.556209) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.556715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.557395) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.591806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.592212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.647705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.648063) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.699319) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.699699) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.700121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.700529) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 05:30:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-23 05:30:16 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.819759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.820118) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021928 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:15.894259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-23 05:30:15.894746) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f7c184ccd800b2ed512c23fb609007efd198eaf --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 5f7c184ccd800b2ed512c23fb609007efd198eaf --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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 05:30:16,646 truncating revision to first 12 chars 2016-01-23 05:30:16,646 Setting DEBUG logging. 2016-01-23 05:30:16,646 attempt 1/10 2016-01-23 05:30:16,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f7c184ccd80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 05:30:17,703 unpacking tar archive at: mozilla-central-5f7c184ccd80/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-23 05:30:17.251094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.251641) ========= echo 5f7c184ccd800b2ed512c23fb609007efd198eaf in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5f7c184ccd800b2ed512c23fb609007efd198eaf'] 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5f7c184ccd800b2ed512c23fb609007efd198eaf program finished with exit code 0 elapsedTime=0.003941 script_repo_revision: '5f7c184ccd800b2ed512c23fb609007efd198eaf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.303748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.304259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 05:30:17.316742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-23 05:30:17.317180) ========= /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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:18 INFO - MultiFileLogger online at 20160123 05:30:18 in /builds/slave/test-pgo 05:30:18 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 05:30:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:30:18 INFO - {'append_to_log': False, 05:30:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:30:18 INFO - 'blob_upload_branch': 'Firefox', 05:30:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:30:18 INFO - 'branch': 'Firefox', 05:30:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:18 INFO - 'config_files': ('talos/linux_config.py',), 05:30:18 INFO - 'default_actions': ('clobber', 05:30:18 INFO - 'read-buildbot-config', 05:30:18 INFO - 'download-and-extract', 05:30:18 INFO - 'populate-webroot', 05:30:18 INFO - 'create-virtualenv', 05:30:18 INFO - 'install', 05:30:18 INFO - 'run-tests'), 05:30:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:18 INFO - 'download_minidump_stackwalk': True, 05:30:18 INFO - 'download_symbols': 'ondemand', 05:30:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:18 INFO - 'installer_path': 'installer.exe', 05:30:18 INFO - 'log_level': 'info', 05:30:18 INFO - 'log_name': 'talos', 05:30:18 INFO - 'log_to_console': True, 05:30:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:18 INFO - 'opt_config_files': (), 05:30:18 INFO - 'pip_index': False, 05:30:18 INFO - 'sps_profile': False, 05:30:18 INFO - 'sps_profile_interval': 0, 05:30:18 INFO - 'suite': 'dromaeojs', 05:30:18 INFO - 'system_bits': '32', 05:30:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:18 INFO - 'title': 'talos-linux64-ix-002', 05:30:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:18 INFO - 'use_talos_json': True, 05:30:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:30:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:18 INFO - 'work_dir': 'build'} 05:30:18 INFO - ##### 05:30:18 INFO - ##### Running clobber step. 05:30:18 INFO - ##### 05:30:18 INFO - Running pre-action listener: _resource_record_pre_action 05:30:18 INFO - Running main action method: clobber 05:30:18 INFO - rmtree: /builds/slave/test-pgo/build 05:30:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:30:18 INFO - Running post-action listener: _resource_record_post_action 05:30:18 INFO - ##### 05:30:18 INFO - ##### Running read-buildbot-config step. 05:30:18 INFO - ##### 05:30:18 INFO - Running pre-action listener: _resource_record_pre_action 05:30:18 INFO - Running main action method: read_buildbot_config 05:30:18 INFO - Using buildbot properties: 05:30:18 INFO - { 05:30:18 INFO - "project": "", 05:30:18 INFO - "product": "firefox", 05:30:18 INFO - "script_repo_revision": "production", 05:30:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:30:18 INFO - "repository": "", 05:30:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:30:18 INFO - "buildid": "20160123030348", 05:30:18 INFO - "stage_platform": "linux64-pgo", 05:30:18 INFO - "basedir": "/builds/slave/test-pgo", 05:30:18 INFO - "nightly_build": "True", 05:30:18 INFO - "buildnumber": 165, 05:30:18 INFO - "slavename": "talos-linux64-ix-002", 05:30:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:30:18 INFO - "platform": "ubuntu64_hw", 05:30:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:30:18 INFO - "branch": "mozilla-central", 05:30:18 INFO - "repo_path": "mozilla-central", 05:30:18 INFO - "revision": "5f7c184ccd800b2ed512c23fb609007efd198eaf", 05:30:18 INFO - "pgo_build": "True", 05:30:18 INFO - "builduid": "ba4172364f6c4da2befe2605e4704566", 05:30:18 INFO - "slavebuilddir": "test" 05:30:18 INFO - } 05:30:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:30:18 INFO - Running post-action listener: _resource_record_post_action 05:30:18 INFO - ##### 05:30:18 INFO - ##### Running download-and-extract step. 05:30:18 INFO - ##### 05:30:18 INFO - Running pre-action listener: _resource_record_pre_action 05:30:18 INFO - Running main action method: download_and_extract 05:30:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:30: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')]} 05:30:18 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json 05:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json 05:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:30:22 INFO - Downloaded 1448 bytes. 05:30:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:30:22 INFO - Using the following test package requirements: 05:30:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:22 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:30:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'jsshell-linux-x86_64.zip'], 05:30:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:30:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:30:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30: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')]} 05:30:22 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:25 INFO - Downloaded 22488900 bytes. 05:30:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:27 INFO - Return code: 0 05:30:27 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 05:30:27 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')]} 05:30:27 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:36 INFO - Downloaded 22488900 bytes. 05:30:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:37 INFO - Return code: 0 05:30:37 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')]} 05:30:37 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:39 INFO - Downloaded 10706572 bytes. 05:30:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:39 INFO - Return code: 0 05:30: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')]} 05:30:39 INFO - https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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 05:30:41 INFO - Downloaded 55971568 bytes. 05:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:41 INFO - mkdir: /builds/slave/test-pgo/properties 05:30:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:30:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:30:41 INFO - Contents: 05:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:41 INFO - Running post-action listener: _resource_record_post_action 05:30:41 INFO - Running post-action listener: set_extra_try_arguments 05:30:41 INFO - ##### 05:30:41 INFO - ##### Running populate-webroot step. 05:30:41 INFO - ##### 05:30:41 INFO - Running pre-action listener: _resource_record_pre_action 05:30:41 INFO - Running main action method: populate_webroot 05:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:41 INFO - '--tppagecycles', 05:30:41 INFO - '7'], 05:30:41 INFO - 'tests': ['tsvgm']}}, 05:30:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'tests': ['damp', 'tps']}, 05:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['damp', 'tps']}, 05:30:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:41 INFO - 'other': {'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'other_l64': {'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:41 INFO - 'ts_paint', 05:30:41 INFO - 'tpaint', 05:30:41 INFO - 'sessionrestore', 05:30:41 INFO - 'sessionrestore_no_auto_restore']}, 05:30:41 INFO - 'svgr': {'tests': ['tsvgx', 05:30:41 INFO - 'tsvgr_opacity', 05:30:41 INFO - 'tart', 05:30:41 INFO - 'tscrollx', 05:30:41 INFO - 'cart']}, 05:30:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['tsvgx', 05:30:41 INFO - 'tsvgr_opacity', 05:30:41 INFO - 'tart', 05:30:41 INFO - 'tscrollx', 05:30:41 INFO - 'cart']}, 05:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'tests': ['tp5o']}, 05:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--e10s'], 05:30:41 INFO - 'tests': ['tp5o']}, 05:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--xperf_path', 05:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:41 INFO - 'tests': ['tp5n']}, 05:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:41 INFO - 'talos_options': ['--e10s', 05:30:41 INFO - '--xperf_path', 05:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:41 INFO - 'tests': ['tp5n']}}, 05:30:41 INFO - 'talos.zip': {'path': '', 05:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:41 INFO - Running post-action listener: _resource_record_post_action 05:30:41 INFO - ##### 05:30:41 INFO - ##### Running create-virtualenv step. 05:30:41 INFO - ##### 05:30:41 INFO - Running pre-action listener: _resource_record_pre_action 05:30:41 INFO - Running main action method: create_virtualenv 05:30:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:30:41 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 05:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:41 INFO - Using real prefix '/usr' 05:30:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:44 INFO - Installing pip.................done. 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:44 INFO - Using env: {'DISPLAY': ':0', 05:30:44 INFO - 'HOME': '/home/cltbld', 05:30:44 INFO - 'LANG': 'en_US.UTF-8', 05:30:44 INFO - 'LANGUAGE': 'en_US:en', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MAIL': '/var/mail/cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SHLVL': '1', 05:30:44 INFO - 'TERM': 'linux', 05:30:44 INFO - 'TMOUT': '86400', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - '_': '/tools/buildbot/bin/python'} 05:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:44 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 05:30:44 INFO - Cleaning up... 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:44 INFO - Using env: {'DISPLAY': ':0', 05:30:44 INFO - 'HOME': '/home/cltbld', 05:30:44 INFO - 'LANG': 'en_US.UTF-8', 05:30:44 INFO - 'LANGUAGE': 'en_US:en', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MAIL': '/var/mail/cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SHLVL': '1', 05:30:44 INFO - 'TERM': 'linux', 05:30:44 INFO - 'TMOUT': '86400', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - '_': '/tools/buildbot/bin/python'} 05:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:44 INFO - Downloading/unpacking psutil>=0.7.1 05:30:44 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 05:30:44 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 05:30:44 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 05:30:44 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 05:30:44 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 05:30:44 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 05:30:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:46 INFO - Installing collected packages: psutil 05:30:46 INFO - Running setup.py install for psutil 05:30:46 INFO - building 'psutil._psutil_linux' extension 05:30:46 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 05:30:46 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 05:30:47 INFO - building 'psutil._psutil_posix' extension 05:30:47 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 05:30:47 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 05:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:47 INFO - Successfully installed psutil 05:30:47 INFO - Cleaning up... 05:30:47 INFO - Return code: 0 05:30:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:30:47 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')]} 05:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:47 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')]} 05:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:47 INFO - Using env: {'DISPLAY': ':0', 05:30:47 INFO - 'HOME': '/home/cltbld', 05:30:47 INFO - 'LANG': 'en_US.UTF-8', 05:30:47 INFO - 'LANGUAGE': 'en_US:en', 05:30:47 INFO - 'LOGNAME': 'cltbld', 05:30:47 INFO - 'MAIL': '/var/mail/cltbld', 05:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:47 INFO - 'MOZ_NO_REMOTE': '1', 05:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:47 INFO - 'NO_EM_RESTART': '1', 05:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:47 INFO - 'SHELL': '/bin/bash', 05:30:47 INFO - 'SHLVL': '1', 05:30:47 INFO - 'TERM': 'linux', 05:30:47 INFO - 'TMOUT': '86400', 05:30:47 INFO - 'USER': 'cltbld', 05:30:47 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:47 INFO - '_': '/tools/buildbot/bin/python'} 05:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:47 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 05:30:47 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 05:30:47 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 05:30:47 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 05:30:47 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 05:30:47 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 05:30:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:49 INFO - Installing collected packages: mozsystemmonitor 05:30:49 INFO - Running setup.py install for mozsystemmonitor 05:30:49 INFO - Successfully installed mozsystemmonitor 05:30:49 INFO - Cleaning up... 05:30:49 INFO - Return code: 0 05:30:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:30:49 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')]} 05:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 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')]} 05:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:49 INFO - Using env: {'DISPLAY': ':0', 05:30:49 INFO - 'HOME': '/home/cltbld', 05:30:49 INFO - 'LANG': 'en_US.UTF-8', 05:30:49 INFO - 'LANGUAGE': 'en_US:en', 05:30:49 INFO - 'LOGNAME': 'cltbld', 05:30:49 INFO - 'MAIL': '/var/mail/cltbld', 05:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:49 INFO - 'MOZ_NO_REMOTE': '1', 05:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:49 INFO - 'NO_EM_RESTART': '1', 05:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:49 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:49 INFO - 'SHELL': '/bin/bash', 05:30:49 INFO - 'SHLVL': '1', 05:30:49 INFO - 'TERM': 'linux', 05:30:49 INFO - 'TMOUT': '86400', 05:30:49 INFO - 'USER': 'cltbld', 05:30:49 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:49 INFO - '_': '/tools/buildbot/bin/python'} 05:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:49 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:49 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 05:30:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:30:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - Downloading docopt-0.6.1.tar.gz 05:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:52 INFO - Running setup.py install for blobuploader 05:30:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:30:52 INFO - Running setup.py install for requests 05:30:52 INFO - Running setup.py install for docopt 05:30:52 INFO - Successfully installed blobuploader requests docopt 05:30:52 INFO - Cleaning up... 05:30:52 INFO - Return code: 0 05:30:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:52 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')]} 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:52 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')]} 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 05:30:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 05:30:52 INFO - Using env: {'DISPLAY': ':0', 05:30:52 INFO - 'HOME': '/home/cltbld', 05:30:52 INFO - 'LANG': 'en_US.UTF-8', 05:30:52 INFO - 'LANGUAGE': 'en_US:en', 05:30:52 INFO - 'LOGNAME': 'cltbld', 05:30:52 INFO - 'MAIL': '/var/mail/cltbld', 05:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:52 INFO - 'MOZ_NO_REMOTE': '1', 05:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:52 INFO - 'NO_EM_RESTART': '1', 05:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:52 INFO - 'SHELL': '/bin/bash', 05:30:52 INFO - 'SHLVL': '1', 05:30:52 INFO - 'TERM': 'linux', 05:30:52 INFO - 'TMOUT': '86400', 05:30:52 INFO - 'USER': 'cltbld', 05:30:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:52 INFO - '_': '/tools/buildbot/bin/python'} 05:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:52 INFO - Running setup.py (path:/tmp/pip-8QoE8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:53 INFO - Running setup.py (path:/tmp/pip-nEtizi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:53 INFO - Running setup.py (path:/tmp/pip-7RRK1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:53 INFO - Running setup.py (path:/tmp/pip-_JzI9J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:53 INFO - Running setup.py (path:/tmp/pip-hvokjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:53 INFO - Running setup.py (path:/tmp/pip-yNEsUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:53 INFO - Running setup.py (path:/tmp/pip-N8ItmJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:53 INFO - Running setup.py (path:/tmp/pip-ViAiIW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:53 INFO - Running setup.py (path:/tmp/pip-ciezMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:53 INFO - Running setup.py (path:/tmp/pip-NJ21id-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:53 INFO - Running setup.py (path:/tmp/pip-noqtXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:53 INFO - Running setup.py (path:/tmp/pip-Zp57D8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:53 INFO - Running setup.py (path:/tmp/pip-4ANXDB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:53 INFO - Running setup.py (path:/tmp/pip-JdOXYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:53 INFO - Running setup.py (path:/tmp/pip-d70CdL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:54 INFO - Running setup.py (path:/tmp/pip-xb4Zep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:54 INFO - Running setup.py (path:/tmp/pip-yxIF4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:54 INFO - Running setup.py install for manifestparser 05:30:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Running setup.py install for mozcrash 05:30:54 INFO - Running setup.py install for mozdebug 05:30:54 INFO - Running setup.py install for mozdevice 05:30:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Running setup.py install for mozfile 05:30:54 INFO - Running setup.py install for mozhttpd 05:30:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Running setup.py install for mozinfo 05:30:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Running setup.py install for mozInstall 05:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:30:54 INFO - Running setup.py install for mozleak 05:30:55 INFO - Running setup.py install for mozlog 05:30:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for moznetwork 05:30:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozprocess 05:30:55 INFO - Running setup.py install for mozprofile 05:30:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozrunner 05:30:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozscreenshot 05:30:55 INFO - Running setup.py install for moztest 05:30:55 INFO - Running setup.py install for mozversion 05:30:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:55 INFO - Cleaning up... 05:30:55 INFO - Return code: 0 05:30:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:55 INFO - Using env: {'DISPLAY': ':0', 05:30:55 INFO - 'HOME': '/home/cltbld', 05:30:55 INFO - 'LANG': 'en_US.UTF-8', 05:30:55 INFO - 'LANGUAGE': 'en_US:en', 05:30:55 INFO - 'LOGNAME': 'cltbld', 05:30:55 INFO - 'MAIL': '/var/mail/cltbld', 05:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:55 INFO - 'MOZ_NO_REMOTE': '1', 05:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:55 INFO - 'NO_EM_RESTART': '1', 05:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:55 INFO - 'SHELL': '/bin/bash', 05:30:55 INFO - 'SHLVL': '1', 05:30:55 INFO - 'TERM': 'linux', 05:30:55 INFO - 'TMOUT': '86400', 05:30:55 INFO - 'USER': 'cltbld', 05:30:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:55 INFO - '_': '/tools/buildbot/bin/python'} 05:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:56 INFO - Running setup.py (path:/tmp/pip-Kj0MiO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:56 INFO - Running setup.py (path:/tmp/pip-olr8P3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:56 INFO - Running setup.py (path:/tmp/pip-qrts4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:56 INFO - Running setup.py (path:/tmp/pip-dYHvdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:56 INFO - Running setup.py (path:/tmp/pip-VOfkJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:56 INFO - Running setup.py (path:/tmp/pip-lGJ_hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:56 INFO - Running setup.py (path:/tmp/pip-4AwkoU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:56 INFO - Running setup.py (path:/tmp/pip-Ua1Djn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:56 INFO - Running setup.py (path:/tmp/pip-niz0aX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:56 INFO - Running setup.py (path:/tmp/pip-IXzKq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:56 INFO - Running setup.py (path:/tmp/pip-kwO0q7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:56 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)) 05:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:56 INFO - Running setup.py (path:/tmp/pip-5Jmc6Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:57 INFO - Running setup.py (path:/tmp/pip-8Ob66c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:57 INFO - Running setup.py (path:/tmp/pip-3eqhkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:57 INFO - Running setup.py (path:/tmp/pip-cht7ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:57 INFO - Running setup.py (path:/tmp/pip-5n68kl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:57 INFO - Running setup.py (path:/tmp/pip-D8eii7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:57 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)) 05:30:57 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)) 05:30:57 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)) 05:30:57 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)) 05:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:59 INFO - Downloading blessings-1.6.tar.gz 05:30:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:59 INFO - Installing collected packages: blessings 05:30:59 INFO - Running setup.py install for blessings 05:30:59 INFO - Successfully installed blessings 05:30:59 INFO - Cleaning up... 05:30:59 INFO - Return code: 0 05:30:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:30:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:30:59 INFO - Reading from file tmpfile_stdout 05:30:59 INFO - Current package versions: 05:30:59 INFO - argparse == 1.2.1 05:30:59 INFO - blessings == 1.6 05:30:59 INFO - blobuploader == 1.2.4 05:30:59 INFO - docopt == 0.6.1 05:30:59 INFO - manifestparser == 1.1 05:30:59 INFO - mozInstall == 1.12 05:30:59 INFO - mozcrash == 0.16 05:30:59 INFO - mozdebug == 0.1 05:30:59 INFO - mozdevice == 0.48 05:30:59 INFO - mozfile == 1.2 05:30:59 INFO - mozhttpd == 0.7 05:30:59 INFO - mozinfo == 0.9 05:30:59 INFO - mozleak == 0.1 05:30:59 INFO - mozlog == 3.1 05:30:59 INFO - moznetwork == 0.27 05:30:59 INFO - mozprocess == 0.22 05:30:59 INFO - mozprofile == 0.28 05:30:59 INFO - mozrunner == 6.11 05:30:59 INFO - mozscreenshot == 0.1 05:30:59 INFO - mozsystemmonitor == 0.0 05:30:59 INFO - moztest == 0.7 05:30:59 INFO - mozversion == 1.4 05:30:59 INFO - psutil == 3.1.1 05:30:59 INFO - requests == 1.2.3 05:30:59 INFO - wsgiref == 0.1.2 05:30:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:59 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')]} 05:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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')]} 05:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:59 INFO - Using env: {'DISPLAY': ':0', 05:30:59 INFO - 'HOME': '/home/cltbld', 05:30:59 INFO - 'LANG': 'en_US.UTF-8', 05:30:59 INFO - 'LANGUAGE': 'en_US:en', 05:30:59 INFO - 'LOGNAME': 'cltbld', 05:30:59 INFO - 'MAIL': '/var/mail/cltbld', 05:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:59 INFO - 'MOZ_NO_REMOTE': '1', 05:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:59 INFO - 'NO_EM_RESTART': '1', 05:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:59 INFO - 'SHELL': '/bin/bash', 05:30:59 INFO - 'SHLVL': '1', 05:30:59 INFO - 'TERM': 'linux', 05:30:59 INFO - 'TMOUT': '86400', 05:30:59 INFO - 'USER': 'cltbld', 05:30:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:59 INFO - '_': '/tools/buildbot/bin/python'} 05:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 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)) 05:30:59 INFO - Cleaning up... 05:30:59 INFO - Return code: 0 05:30:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:30:59 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')]} 05:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 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')]} 05:30:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:30:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:30:59 INFO - Using env: {'DISPLAY': ':0', 05:30:59 INFO - 'HOME': '/home/cltbld', 05:30:59 INFO - 'LANG': 'en_US.UTF-8', 05:30:59 INFO - 'LANGUAGE': 'en_US:en', 05:30:59 INFO - 'LOGNAME': 'cltbld', 05:30:59 INFO - 'MAIL': '/var/mail/cltbld', 05:30:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:59 INFO - 'MOZ_NO_REMOTE': '1', 05:30:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:59 INFO - 'NO_EM_RESTART': '1', 05:30:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:59 INFO - 'SHELL': '/bin/bash', 05:30:59 INFO - 'SHLVL': '1', 05:30:59 INFO - 'TERM': 'linux', 05:30:59 INFO - 'TMOUT': '86400', 05:30:59 INFO - 'USER': 'cltbld', 05:30:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:30:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:59 INFO - '_': '/tools/buildbot/bin/python'} 05:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:00 INFO - Downloading/unpacking jsonschema 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:01 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:02 INFO - warning: no files found matching '*.txt' 05:31:02 INFO - no previously-included directories found matching 'build' 05:31:02 INFO - no previously-included directories found matching 'dist' 05:31:02 INFO - no previously-included directories found matching '.git*' 05:31:02 INFO - Installing collected packages: jsonschema, functools32 05:31:02 INFO - Running setup.py install for functools32 05:31:02 INFO - warning: no files found matching '*.txt' 05:31:02 INFO - no previously-included directories found matching 'build' 05:31:02 INFO - no previously-included directories found matching 'dist' 05:31:02 INFO - no previously-included directories found matching '.git*' 05:31:02 INFO - Successfully installed jsonschema functools32 05:31:02 INFO - Cleaning up... 05:31:02 INFO - Return code: 0 05:31:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:31: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')]} 05:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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')]} 05:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fc004cd3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, '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': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', '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 05:31:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 05:31:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 05:31:02 INFO - Using env: {'DISPLAY': ':0', 05:31:02 INFO - 'HOME': '/home/cltbld', 05:31:02 INFO - 'LANG': 'en_US.UTF-8', 05:31:02 INFO - 'LANGUAGE': 'en_US:en', 05:31:02 INFO - 'LOGNAME': 'cltbld', 05:31:02 INFO - 'MAIL': '/var/mail/cltbld', 05:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:02 INFO - 'MOZ_NO_REMOTE': '1', 05:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:02 INFO - 'NO_EM_RESTART': '1', 05:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:02 INFO - 'SHELL': '/bin/bash', 05:31:02 INFO - 'SHLVL': '1', 05:31:02 INFO - 'TERM': 'linux', 05:31:02 INFO - 'TMOUT': '86400', 05:31:02 INFO - 'USER': 'cltbld', 05:31:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:02 INFO - '_': '/tools/buildbot/bin/python'} 05:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:02 INFO - Downloading/unpacking flake8 05:31:02 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 05:31:02 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 05:31:02 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 05:31:02 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 05:31:02 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 05:31:02 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 05:31:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 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 05:31:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:04 INFO - no previously-included directories found matching 'docs/_build' 05:31:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:05 INFO - Running setup.py install for pep8 05:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:05 INFO - no previously-included directories found matching 'docs/_build' 05:31:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:31:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:05 INFO - Cleaning up... 05:31:05 INFO - Return code: 0 05:31:05 INFO - Running post-action listener: _resource_record_post_action 05:31:05 INFO - Running post-action listener: _start_resource_monitoring 05:31:05 INFO - Starting resource monitoring. 05:31:05 INFO - ##### 05:31:05 INFO - ##### Running install step. 05:31:05 INFO - ##### 05:31:05 INFO - Running pre-action listener: _resource_record_pre_action 05:31:05 INFO - Running main action method: install 05:31:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:05 INFO - Reading from file tmpfile_stdout 05:31:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:31:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:31:05 INFO - Reading from file tmpfile_stdout 05:31:05 INFO - Output received: 05:31:05 INFO - Usage: mozinstall [options] installer 05:31:05 INFO - Options: 05:31:05 INFO - -h, --help show this help message and exit 05:31:05 INFO - -d DEST, --destination=DEST 05:31:05 INFO - Directory to install application into. [default: 05:31:05 INFO - "/builds/slave/test-pgo"] 05:31:05 INFO - --app=APP Application being installed. [default: firefox] 05:31:05 INFO - mkdir: /builds/slave/test-pgo/build/application 05:31:05 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'] 05:31:05 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 05:31:21 INFO - Reading from file tmpfile_stdout 05:31:21 INFO - Output received: 05:31:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:31:21 INFO - Running post-action listener: _resource_record_post_action 05:31:21 INFO - ##### 05:31:21 INFO - ##### Running run-tests step. 05:31:21 INFO - ##### 05:31:21 INFO - Running pre-action listener: _resource_record_pre_action 05:31:21 INFO - Running main action method: run_tests 05:31:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:31:21 INFO - Python 2.7.3 05:31:21 INFO - Return code: 0 05:31:21 INFO - grabbing minidump binary from tooltool 05:31: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')]} 05:31:21 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 0x1250840>, '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 0x11bd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:31:21 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 05:31:21 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 05:31:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:21 INFO - Return code: 0 05:31:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:31:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:31:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:31:22 INFO - Return code: 0 05:31:22 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/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:31:22 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/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 05:31:22 INFO - Using env: {'DISPLAY': ':0', 05:31:22 INFO - 'HOME': '/home/cltbld', 05:31:22 INFO - 'LANG': 'en_US.UTF-8', 05:31:22 INFO - 'LANGUAGE': 'en_US:en', 05:31:22 INFO - 'LOGNAME': 'cltbld', 05:31:22 INFO - 'MAIL': '/var/mail/cltbld', 05:31:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:22 INFO - 'MOZ_NO_REMOTE': '1', 05:31:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:22 INFO - 'NO_EM_RESTART': '1', 05:31:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:31:22 INFO - 'SHELL': '/bin/bash', 05:31:22 INFO - 'SHLVL': '1', 05:31:22 INFO - 'TERM': 'linux', 05:31:22 INFO - 'TMOUT': '86400', 05:31:22 INFO - 'USER': 'cltbld', 05:31:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676', 05:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:22 INFO - '_': '/tools/buildbot/bin/python'} 05:31:22 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/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:31:22 INFO - mozversion application_buildid: 20160123030348 05:31:22 INFO - mozversion application_changeset: 5f7c184ccd800b2ed512c23fb609007efd198eaf 05:31:22 INFO - mozversion application_display_name: Nightly 05:31:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:22 INFO - mozversion application_name: Firefox 05:31:22 INFO - mozversion application_remotingname: firefox 05:31:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:22 INFO - mozversion application_vendor: Mozilla 05:31:22 INFO - mozversion application_version: 46.0a1 05:31:22 INFO - mozversion platform_buildid: 20160123030348 05:31:22 INFO - mozversion platform_changeset: 5f7c184ccd800b2ed512c23fb609007efd198eaf 05:31:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:22 INFO - mozversion platform_version: 46.0a1 05:31:22 INFO - using testdate: 1453555882 05:31:22 INFO - actual date: 1453555882 05:31:23 INFO - starting webserver on 'localhost:48106' 05:31:23 INFO - SUITE-START | Running 3 tests 05:31:23 INFO - TEST-START | dromaeo_css 05:31:23 INFO - operating with platform_type : linux_ 05:31:23 INFO - Initialising browser for dromaeo_css test... 05:31:23 INFO - TEST-INFO | started process 6630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYJiKCa/profile http://localhost:48106/getInfo.html) 05:31:26 INFO - PROCESS | 6630 | __metrics Screen width/height:1600/1200 05:31:26 INFO - PROCESS | 6630 | colorDepth:24 05:31:26 INFO - PROCESS | 6630 | Browser inner width/height: 1024/697 05:31:26 INFO - PROCESS | 6630 | __metrics 05:31:27 INFO - PROCESS | 6630 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:31:27 INFO - PROCESS | 6630 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:28 INFO - TEST-INFO | 6630: exit 0 05:31:28 INFO - Browser initialized. 05:31:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:28 INFO - TEST-INFO | started process 6720 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYJiKCa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:40 INFO - PROCESS | 6720 | RSS: Main: 148340736 05:31:40 INFO - PROCESS | 6720 | 05:32:31 INFO - PROCESS | 6720 | 1453555951380 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] 05:34:39 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48106/tests/dromaeo/cssquery-ext.html) 05:34:40 INFO - PROCESS | 6720 | RSS: Main: 245501952 05:34:40 INFO - PROCESS | 6720 | 05:37:42 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-ext.html (next: http://localhost:48106/tests/dromaeo/cssquery-jquery.html) 05:37:43 INFO - PROCESS | 6720 | RSS: Main: 227131392 05:37:43 INFO - PROCESS | 6720 | 05:40:45 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48106/tests/dromaeo/cssquery-mootools.html) 05:40:46 INFO - PROCESS | 6720 | RSS: Main: 222679040 05:40:46 INFO - PROCESS | 6720 | 05:43:47 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48106/tests/dromaeo/cssquery-prototype.html) 05:43:48 INFO - PROCESS | 6720 | RSS: Main: 213831680 05:43:48 INFO - PROCESS | 6720 | 05:46:50 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48106/tests/dromaeo/cssquery-yui.html) 05:46:51 INFO - PROCESS | 6720 | RSS: Main: 210485248 05:46:51 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | Cycle 1(1): loaded http://localhost:48106/tests/dromaeo/cssquery-yui.html (next: http://localhost:48106/tests/dromaeo/cssquery-dojo.html) 05:49:54 INFO - PROCESS | 6720 | RSS: Main: 271077376 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | __start_tp_report 05:49:54 INFO - PROCESS | 6720 | _x_x_mozilla_page_load 05:49:54 INFO - PROCESS | 6720 | _x_x_mozilla_page_load_details 05:49:54 INFO - PROCESS | 6720 | |i|pagename|runs| 05:49:54 INFO - PROCESS | 6720 | |0;dojo.html;3086.845657717114;3128.7653425993058;3169.0809665197094;3172.4606816841133;3185.872565097396;5018.698878067318;5102.6428150029515;5111.74441277936;5135.05001574709;5167.819126330579;5068.873278168047;5082.390113186413;5086.898262034757;5092.9236061459105;5099.413567439737;4662.766861656912;4671.346011558385;4687.460941991681;4733;4781.856544303659;4700.036492519025;4703.623710103184;4757.04859028194;4757.310190022445;4767.618590512768;4622.214223581999;4649.20963436215;4658.906821863544;4683.88290292742;4697.295405689139;4647.55848194421;4654.930176047362;4678.485366609671;4699.953000469985;4709;4656.301554766778;4686.08621318843;4686.953130468686;4688.249880019181;4695.765211739399;4932.383452068491;4980.526849949249;4991.450940396553;4992.750362481861;4997.450280469146;5434.103372943459;5436.972815135939;5446.863828404282;5453.072977593819;5458.372287186945;5482.479164479368;5488.9725551372385;5493.148561972901;5493.983613031602;5577.079781836032;5179.404368497596;5184.092783762864;5184.222366644995;5185.066687996159;5186.688798672054;5579.442055794388;5588.050031494656;5623.465770751772;5630.971845140748;5631.774729010794;5240.816571420059;5307.62846600742;5389.730513474311;5419.078756611386;5488.423715509894;5483.177523371526;5485.204645326485;5498.120300751861;5498.3127109111365;5503.862403439946;5432.538234250133;5457.072297709319;5473.042217611902;5481.342238931354;5525.281713377235;5376.569874410038;5461.535769459561;5463.808766693147;5473.917891231635;5551.694656793915;4276.102018576072;4290.227759003347;4295.570442955679;4303.376010478463;4318.762468064224;3769.5099637047556;3832.2335532893535;3833.022579242331;3862.497875276252;3871.5741268460447;5067.619928505377;5105.693658380509;5110.259012443249;5110.872228194325;5153.793848246029;5469;5517.2551705520045;5520.779168833202;5523.005858945428;5525.861853453615;4949.579285760678;5040.697558146523;5128.769205385692;5136.563392111638;5163.044836705221;4596.287575425815;4625.560571745679;4649.5350464953235;4652;4682.742449165328;5701.800436984686;5704.971475142681;5706.80026199081;5712.143178523254;5747.195392645033;5386.434424385383;5454.481824226692;5513.173024046425;5522.475364840334;5529.778808847601;5657.377688454185;5672.319321681424;5676.914846277392;5680.602357835077;5730.341010783646;5430.104032834696;5434.972825135849;5435.184722291688;5441.918371224356;5443.401225865231;5391.514763671288;5500;5511.311086114236;5558.666480011212;5563.8887222256135;5429.185622156708;5441.183822426668;5445.074337362737;5454.400015998316;5469.644473109235;5378.139497680352;5406.918896216481;5408.75660595282;5417.891642167214;5453.563714902878;5150.072986862401;5253.763580638957;5290.391604965324;5344.064788661891;5375.946240537544;5456.263404440349;5459.535939445192;5462.535684466865;5474.8905021898545;5531.502164805187;5300.522952934254;5340.546053585489;5346.759395827119;5353.384360798558;5354.437784032621 05:49:54 INFO - PROCESS | 6720 | |1;ext.html;503.9269305950635;541.3044238153972;547.0563278344858;564.991525127123;581.9883602327951;28027.299317517074;28218.294542636446;28404.857975710143;28410.715892841064;34534.136646583785;37345.25309493808;38124.61875381245;38442.42336364957;38479.23041539174;38484.230315393674;8380.958095209531;8579.742607721779;8580;8590.398672092955;8593.44142630727;8282.627281772304;8396.202360775716;8419.621117049748;8423.15768423159;8424.705135320264;8421.578921053953;8733.12668733128;8739.344549158839;8741;8751.343649226334;8591.26974207193;8631.95684021579;8644.265237454823;8644.870326945102;8647.827043459127;8460.957695211546;8601;8610.655573777041;8613.267872230805;8618.525981071101;37336.81331593324;37922.62077379246;37935.24129517394;38128.42807357892;38223.808880955694;3117.719405253538;3232.9838350808095;3266.3467306538787;3852.672522835562;3901.648851603369;30979.690203097907;31079;31719.207019824687;33160.50259246113;34026;3950.1309711863346;3995.860144894944;4063.634272915422;4080.3063479208604;4094.9795251023556;256529;258315.9999999981;258711;258902;259289;56286.718566406904;57417.42582574121;61754;62540;62716;68701;70240.64879675569;70334.64832675907;70386.64806676036;70402;15577.688446231012;15900.68198636044;15915.681686366208;15929.601759955862;15936.28286727077;11076.556937722562;11275.887241127484;11306.491207895664;11360.545578176945;11949.820752688716;20672.069756860976;20958.685619715718;20975;21071.894640526698;21153.68269475959;8271.8345633087;8443.155684431631;8463.31384248802;8547.35894807892;8683.131686831266;907.9909200908038;942.6559305853314;978.4520668425704;997.5211898288717;1022.9386236825815;27053.32366690809;28296;28350;28618.427631447255;28738.71261287402;967.8451447768323;1021.8927012663712;1070.4326706845384;1094.4473041114186;1114.8160553508742;14619.634509137357;14671.486497972519;14719.926400368144;14985.475508357154;15000.399984000736;301606;308191;308746;309014;309429;48393.75803120962;48905;48978.51021489811;49309.50690493121;49358.506414936106;1266.1896386312767;1331.973360532784;1339.3838834136407;1349.291621898511;1351.797230415426;26733.732662673123;27580.862095689394;27886.442271154057;28100.578491322238;28130.71869281281;41604.58395416007;42034;44169.55830441655;44518.551479667636;46682;233370;238624;239221.80389097944;239245;240438;32289;32368.190795230308;32491.83754081309;32672.673273266962;32694.509582355808;32363.51454728134;35481.82259088688;35815.82092089523;38283.61716382801;44381.778091109336;32652;34390.82804585961;34538.82730586331;34565.30869382548;35518.46722299219;34460.82769586136;34781.30437391187;35227.64772352346;35231;35361.469577956865;33414.498782517796;33541.40948687329;33702;33878.66121338755;33898.66101338955;29891.701082988893;30932.690673093883;31169.220769480944;31280.21799455032;31425.371492570477;23603.763962360845;23825.880870595534;23944.40138996539;24148;26163.345916352242 05:49:54 INFO - PROCESS | 6720 | |2;jquery.html;364.6699736738251;368.97601655892356;370.77197523523023;372.1923426165222;374.93251214781327;13539;13558.050936434454;15687.52937411878;16253.431129910456;16979.32082716693;15289.311980960856;15413;15892.76160857588;15909.204539773023;15935.681286374265;4670.719756814594;5357.919631205535;5376.51611354978;5378.515933565978;5378.8924221515545;3952.9209415811665;4075.0219947212604;5295.549878260353;5375.43557926418;5746.396628354005;5716.7141642917895;5884.293884733838;5936.347001829795;5938.198343223674;5939.1388248703915;5696.3733989261145;5729.197912292282;5747.827565173052;5750;5751.424857514278;4978.576820970222;5093.312402825608;5099.286099946011;5159.871003224912;5161.148410512261;19351.322703705442;19507.707384389247;19580.902095489575;19650.70523942142;19805.801941980684;2097.119209931817;2103.22180793106;2114.3339847948;2115.841311901598;2227.4343348192833;12028;12338.629841104781;12348.876511234863;12389.380530973505;13205.801912971314;1688.8480036796625;1703.7699910512047;1714.2457318779698;1774.0952114421739;1866.150901339887;53233.46766532324;53603;54087.45912540903;54226.45773542253;54443;9542.666006689733;9967.00329967012;9977;9985.400875947322;10007.549660265306;13390.732185356239;13460.730785384434;13564.593062208149;13565.25391103479;13590.524331648543;7224.313690199528;7270.236625154388;7292.489525733148;7295.379892709073;7313.268673132644;6835.282295359015;6849.2465828758795;6856.177258728984;6896.689648965808;6899.93100069003;4432.778361081933;4475.597196252353;4534.77326133692;4546.772661366918;4559.700485361723;1734.843864052216;1786.2319202742685;1794.1251392295082;1840.7694496159422;1861.9255229790656;422.66820545871957;889.973300800977;907.1563445995288;970.3547141151197;986.4771671014374;7964.800879977931;10232.846507302396;10647.733806654896;10940.835887461695;11258.605948791917;447.03663604931427;450.9932351014737;476.1025466994671;479.8968221832323;481.8434008947106;5845.181674565564;5858.53131749459;5975.611585246945;6158.860610787019;6253.906191407133;345326;359986;376700;526650;535725;61897.69051154715;73543;74275;74383.62808185925;77873.61063194647;482.8985912958318;485.3617492996698;486.48918635432653;487.4516169309527;488.8044782087122;10221.182305415401;10385.428801415994;10449.373037617766;10467.267291289842;10772.784544308914;32416.67583324231;33341.49987750234;33908.15229619181;33952.490712639825;34151;42711.7864410676;43092.56907431011;43280.35079473873;43608;43833.78083109564;4487.6312724618;7130;7142.535735177197;7333.339999400079;7527.8118047049265;9237.307201960015;9987.500624968869;10218.846717299395;10667.46662666848;10940.890591093987;8701.477911325088;8932;9128.771780705536;9539.76150596213;9589.952050239704;9150;9349.205317548085;9557.23542116643;10234;10421;9639.759006024906;9773.9022609773;9888.703338899844;10199.439030853375;10202.693919182437;7467.58928258951;7522.699092036257;7548.509346892434;7761.953458209798;7814.21857814214;7576.469647124648;9895.208383329173;9962.352447090916;10095.545700443645;10106.898931010595 05:49:54 INFO - PROCESS | 6720 | |3;mootools.html;1297.5134324628264;1451.2671101093947;1477.593661743021;1633.428300094966;1782.74150248214;6841.8289542761395;7388.482806203561;7513.0233069700935;7547.358474529671;7552.055993000875;7479.439042071839;7630.465867389271;7641.274078962503;7643.9235607643905;7662.118856331524;2319.93040208794;2343.9179628713;2344.4373350395867;2346.3664810501155;2348.037304705071;2253.5154941687533;2267.8299127565415;2276.123692378438;2291.140822191678;2295.2540424362064;2294.5869743446174;2322.245270287155;2332.696749422581;2340.625499920013;2356.799672027871;2305.4697419593585;2313.2713195343413;2319.652052192176;2321.8839058047115;2324.639680849471;2311.4914718761847;2318.3508617587104;2319.3969567912295;2321.280403075052;2322.825788065885;7695.846083078307;7721.0734711834375;7730.342920851735;7734.729284475073;7741.380689544823;4649.18639238132;4721.220998535237;4745.1695953208055;4775.904481910342;4778.331033655291;3086.5678804967324;3116.40788250234;3146.5437511560694;3160.4943209086664;3162.8734850605947;1074.897884700952;1084.902358787705;1112.1214240749798;1152.3489228585906;1161.9302841829517;10381.273310868242;10388.896111038945;10396.272260941661;10405.219608529314;10408.063274305274;4212.241796476603;4216.873493795191;4243.745375277494;4416.823327066945;4431.224535706238;9143;9158.40470369424;9171.633134674672;9181.173694367539;9198.586063627154;4799.9760001199775;4802.039592081597;4819.542143496362;4844.273358996108;4849.345338379344;3835.5972622874756;3861.806909654506;4234.9364759528635;4357.782110894443;4455.465344158722;3729.272791805626;3740;3743.9625603743616;3794.1842503861803;3819.0834199792407;1141.577616281981;1228.2937311046005;1234.3766397968968;1235.6416639174538;1239.69007748063;969.5927710361665;1039.0804138337473;1121.685927940178;1138.5901075612774;1312.4422120598708;6834.760783372558;6921;6953.513254072268;7015.649217539102;7032.859342813115;1103.2387652519735;1112.844201811747;1114.3202646385698;1114.3982249585133;1126.921115521922;5466.453354664502;5505.476979687003;5513.035218836688;5524.171374293888;5620.072688006515;8869.246114080375;8870.73387798367;8877.911220887838;8975.551222438851;9188.586513606904;8872.112788721077;8936.151065648754;8946.418482798597;8948.463092214357;8978.371513993958;6944.236134025253;7032.789016329519;7219.494635375473;7251.948467472293;7303.3792127668685;7047.365737083687;7078.044463997295;7109.893351599627;7118.786436406709;7131.144262688511;8176.345892328718;8322.334213262804;8350.248477637042;8517.787055323666;8547.102554231717;8500.61747221389;8577.699780507652;8688.913110869064;8843.955780221058;8848.690295839871;6922.965385173244;6927.58434493932;7021.613811240431;7055;7056.1179852518435;7438.73964411243;7491.625418728932;7493.587852668155;7495.1005879294835;7502.512336698097;5844.883102338014;6582;6665.533412661067;6839.62382068991;7237.601931893796;6497.122888410193;6503.642299673564;6505.349465053646;6609.041688955171;6610;6662.933370666426;6857.931420685929;6890;6897.7585784497305;6946.687399067156;6252.687365631791;6483.675816209265;6522.543421960418;6523.054157147092;6529.804105876831;6425.453836423956;6487.416132548094;6508.251551071498;6512.869742605216;6613.834654133492 05:49:54 INFO - PROCESS | 6720 | |4;prototype.html;339.7740502565791;340.9829508524574;343.09594219232315;349.15852794764623;351.37279955279814;5665.3768085510565;5784.652920824754;5792.68140252286;5875.47120759131;5906.822795316142;5636.4927156555905;5760.683162426065;5763.510101641355;5767.711614419283;5781.306243250805;4517.232070548015;4519.954800451987;4531.569500897418;4539.046800171951;4562.931556026662;4352.738835669854;4474.552544745516;4483;4487;4555.430571178603;4390.648748100144;4448.933266001012;4474.0380818124095;4516.954830451703;4523.389342438778;4487.39420178275;4514.210013247669;4521.977390113061;4522.728636281834;4537.4328208973875;4004.8586152946273;4006.278869803434;4011.2579172853116;4013.0569316210667;4015.0966032642714;5451.482109199659;5576.358718747356;5598.1602759585985;5601.719914004283;5602.38373778884;5173.9741301293625;5186.092433824066;5188.066148093341;5190.377154741417;5192.55863251624;6156.107364432132;6163.660998645073;6166.537509686791;6168.475679567242;6173.629582225081;4322.157179350028;4326.675499337531;4332.981749288914;4337.0458499130145;4346.630536404409;6191.938080619181;6451.677416129175;6456.354364563553;6511.251206111263;6527.15147030883;4412.867613971586;4418.734875907456;4420.071784925201;4421.801018954155;4426.579474949875;4465;4470.083632855257;4473.843415480507;4474.351219073216;4481.170983368087;5053.545180933734;5131.229725744613;5142.71715055668;5147.56245719118;5162.845114646567;6172.938270617326;6206.162168107338;6258.593191442542;6264.342244064399;6277.937220627735;1499.9550013499613;1506.4727345429012;1521.9847801522064;1523.9542813715607;1524.3750062474332;1028.861103750999;1044.996803069047;1045.1586472889396;1055.904968552834;1075.5912753153752;5777.566682498829;5794.62334948227;5795.536357091422;5806.187133801272;5809.738561764731;6089.725962331706;6213.906791398133;6226.128342032119;6336.081268216083;6348.746050158034;5810.389909059488;5815.767369305265;5842.328132264844;5867.765289388462;5868.735906884201;3387.5934887813128;3424.7260219182403;3425.7088147507243;3426.280481098997;3429.2969941162;6351.301356850835;6501.934980650228;6521.0544471051435;6571.638559879252;6628.674265146893;6536.934630653727;6541.705623246965;6542.836429089216;6550.6069635822005;6550.6069635822005;6610.603363798187;6617.7683781067435;6625.701843416961;6627.3372662733345;6631.104800851823;6205.720742566686;6371;6371.171747672773;6384.553081284451;6400.167978162809;6315.336889626523;6316.968415157895;6338.492920566251;6340.809775706736;6349.111124442674;6623.701933413105;6626.403623673892;6629.966850165718;6631.104800851823;6631.966840165768;4378.956210437982;4452.732836029849;4456.777161141865;4457.064016556559;4460.286354183315;6353.618782873043;6390.073439351361;6423.29343772194;6427.646479443675;6436.16329877113;6250.156228909221;6267.0286105653695;6268.968655156695;6269.749210031548;6273.686315684289;6134.386561344008;6235.127082208585;6235.875282494234;6238.438540531374;6244.188255526752;6132.969335153296;6145.877082458415;6151.9384806151365;6152.354002829638;6152.969235153974;6239.594426362272;6253.468455181179;6265.185525881606;6284.465820405317;6289.842753931189;5735.340435849764;6109;6114.969425152845;6162.969185154046;6164.198654174928 05:49:54 INFO - PROCESS | 6720 | |5;yui.html;770.2259229474379;799.0571126071236;825.5289628858826;857.9227869491745;862.7023676831495;12854.550090746825;12995.935020324885;13010.284434356106;13045.478180872766;13051.282179480124;12429.627111186655;12547.309897955609;12603.369831508411;12635.684107897285;13075.934620326885;805.9677612895492;816.3754727633366;816.8693009118542;817.3787921179917;817.5503473089807;808.640155130967;811.922867327603;812.273015650992;812.3907069697726;812.8943237379133;842.2335674536173;842.5366048673236;843.1231519220034;844.0209357145712;845.4293351987415;838.3712215838121;838.4550042472441;840.0129847429276;840.2311884625591;841.4110122913924;620.3982137326785;620.8168590265838;621.8973869311558;622.1942584353274;623.0436280309702;12368.75262494745;12370.567030153992;12388.31864247466;12400.379981000913;12410;10538.894611053867;10615.469226538642;10673.893261067367;10842.674719758419;11179.4969226385;9435.575399107056;9534.618615255382;9547.713568592953;9552.856707149398;9579.664711735057;3426.2804810989724;3479.2519608284088;3503.2643144939593;3565.625609311011;3597.37046016946;43919.388464211435;43970.78014609939;44031.559684403386;49148.262776058385;49181.75409122931;10064.718028452171;10077.395356278501;10251.12865406434;10342.948285258675;10440.269181157246;17525.64948701019;17559.824401756076;17562.03408812502;17567.912160439115;17581.120943952752;6099.390060993954;7376.225496322809;7501.774946751606;7518.398528117737;7710.228977102245;3962.148138150254;3977.622125898035;4047.069174089917;4052.1895620875944;4120.62914337711;2962.229820246708;3021.5165573508134;3021.7129372709555;3022.30486987994;3022.818630882154;520.6173462505132;537.5592014548033;544.3685325022955;549.4697616799727;555.2060553408584;531.3066448285025;564.3594520219498;613.7054213977316;638.3680156644888;646.767163821024;8290.165704267982;8393.832123357499;8442.704505342284;8567;8623.525706086226;680.9727610895509;684.3225207045089;685.8388278754488;719.0113593808513;733.7142178170709;3788.8295026723863;4137.937930931039;4192.434021407132;4217.506368385059;4317.8272869084885;53007.73496132572;53210;53720;53735;53746.193807092925;49832.501674982785;50016.74991625091;52929.47070529246;53078.734606327496;54810.45189548133;42540.36189457161;43341.783291083346;44222.778886106;44859.77570112129;44908;8424.157584241771;8768.386212965032;8903.065178156201;8917;9045.63817447321;30742.38515229638;31433;34899.65100348964;35425.82287088548;35936.4609530852;39706.602933971444;40709.79645101756;41152.38271425991;42677;42799;10880.238383313408;10932.836007460053;10963.506642201279;11209.887901120885;11348.375839328586;11746.941265293619;11937.641870743892;12046.51813927433;12117.212381195193;12443.44004519817;10517.368957862553;10916.12670986335;10936.234463587472;11031.889681103086;11281.21031527818;10534.36793792375;10720.785584288427;10737.892621074001;10747.193960453154;10749.301295415773;10731.356118632906;10793.08258798011;10827.621033263798;11119.610813621484;11395.943020284845;8899.777505562413;9010.074115285957;9110.726678199664;9255.53722313895;9408.623655053721;8196.508209507449;8364.414490985573;8808.515531645564;9012.63949442015;9555.283353748358 05:49:54 INFO - PROCESS | 6720 | __end_tp_report 05:49:54 INFO - PROCESS | 6720 | __start_cc_report 05:49:54 INFO - PROCESS | 6720 | _x_x_mozilla_cycle_collect,778 05:49:54 INFO - PROCESS | 6720 | __end_cc_report 05:49:54 INFO - PROCESS | 6720 | __startTimestamp1453556994355__endTimestamp 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | ------- Summary: start ------- 05:49:54 INFO - PROCESS | 6720 | Number of tests: 6 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#0] dojo.html Cycles:165 Average:5108.97 Median:5344.06 stddev:551.42 (10.3%) stddev-sans-first:529.80 05:49:54 INFO - PROCESS | 6720 | Values: 3086.8 3128.8 3169.1 3172.5 3185.9 5018.7 5102.6 5111.7 5135.1 5167.8 5068.9 5082.4 5086.9 5092.9 5099.4 4662.8 4671.3 4687.5 4733.0 4781.9 4700.0 4703.6 4757.0 4757.3 4767.6 4622.2 4649.2 4658.9 4683.9 4697.3 4647.6 4654.9 4678.5 4700.0 4709.0 4656.3 4686.1 4687.0 4688.2 4695.8 4932.4 4980.5 4991.5 4992.8 4997.5 5434.1 5437.0 5446.9 5453.1 5458.4 5482.5 5489.0 5493.1 5494.0 5577.1 5179.4 5184.1 5184.2 5185.1 5186.7 5579.4 5588.1 5623.5 5631.0 5631.8 5240.8 5307.6 5389.7 5419.1 5488.4 5483.2 5485.2 5498.1 5498.3 5503.9 5432.5 5457.1 5473.0 5481.3 5525.3 5376.6 5461.5 5463.8 5473.9 5551.7 4276.1 4290.2 4295.6 4303.4 4318.8 3769.5 3832.2 3833.0 3862.5 3871.6 5067.6 5105.7 5110.3 5110.9 5153.8 5469.0 5517.3 5520.8 5523.0 5525.9 4949.6 5040.7 5128.8 5136.6 5163.0 4596.3 4625.6 4649.5 4652.0 4682.7 5701.8 5705.0 5706.8 5712.1 5747.2 5386.4 5454.5 5513.2 5522.5 5529.8 5657.4 5672.3 5676.9 5680.6 5730.3 5430.1 5435.0 5435.2 5441.9 5443.4 5391.5 5500.0 5511.3 5558.7 5563.9 5429.2 5441.2 5445.1 5454.4 5469.6 5378.1 5406.9 5408.8 5417.9 5453.6 5150.1 5253.8 5290.4 5344.1 5375.9 5456.3 5459.5 5462.5 5474.9 5531.5 5300.5 5340.5 5346.8 5353.4 5354.4 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#1] ext.html Cycles:180 Average:43732.60 Median:34497.48 stddev:70397.37 (204.1%) stddev-sans-first:70520.03 05:49:54 INFO - PROCESS | 6720 | Values: 503.9 541.3 547.1 565.0 582.0 28027.3 28218.3 28404.9 28410.7 34534.1 37345.3 38124.6 38442.4 38479.2 38484.2 8381.0 8579.7 8580.0 8590.4 8593.4 8282.6 8396.2 8419.6 8423.2 8424.7 8421.6 8733.1 8739.3 8741.0 8751.3 8591.3 8632.0 8644.3 8644.9 8647.8 8461.0 8601.0 8610.7 8613.3 8618.5 37336.8 37922.6 37935.2 38128.4 38223.8 3117.7 3233.0 3266.3 3852.7 3901.6 30979.7 31079.0 31719.2 33160.5 34026.0 3950.1 3995.9 4063.6 4080.3 4095.0 256529.0 258316.0 258711.0 258902.0 259289.0 56286.7 57417.4 61754.0 62540.0 62716.0 68701.0 70240.6 70334.6 70386.6 70402.0 15577.7 15900.7 15915.7 15929.6 15936.3 11076.6 11275.9 11306.5 11360.5 11949.8 20672.1 20958.7 20975.0 21071.9 21153.7 8271.8 8443.2 8463.3 8547.4 8683.1 908.0 942.7 978.5 997.5 1022.9 27053.3 28296.0 28350.0 28618.4 28738.7 967.8 1021.9 1070.4 1094.4 1114.8 14619.6 14671.5 14719.9 14985.5 15000.4 301606.0 308191.0 308746.0 309014.0 309429.0 48393.8 48905.0 48978.5 49309.5 49358.5 1266.2 1332.0 1339.4 1349.3 1351.8 26733.7 27580.9 27886.4 28100.6 28130.7 41604.6 42034.0 44169.6 44518.6 46682.0 233370.0 238624.0 239221.8 239245.0 240438.0 32289.0 32368.2 32491.8 32672.7 32694.5 32363.5 35481.8 35815.8 38283.6 44381.8 32652.0 34390.8 34538.8 34565.3 35518.5 34460.8 34781.3 35227.6 35231.0 35361.5 33414.5 33541.4 33702.0 33878.7 33898.7 29891.7 30932.7 31169.2 31280.2 31425.4 23603.8 23825.9 23944.4 24148.0 26163.3 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#2] jquery.html Cycles:180 Average:23926.79 Median:480.87 stddev:71691.19 (14908.6%) stddev-sans-first:71870.47 05:49:54 INFO - PROCESS | 6720 | Values: 364.7 369.0 370.8 372.2 374.9 13539.0 13558.1 15687.5 16253.4 16979.3 15289.3 15413.0 15892.8 15909.2 15935.7 4670.7 5357.9 5376.5 5378.5 5378.9 3952.9 4075.0 5295.5 5375.4 5746.4 5716.7 5884.3 5936.3 5938.2 5939.1 5696.4 5729.2 5747.8 5750.0 5751.4 4978.6 5093.3 5099.3 5159.9 5161.1 19351.3 19507.7 19580.9 19650.7 19805.8 2097.1 2103.2 2114.3 2115.8 2227.4 12028.0 12338.6 12348.9 12389.4 13205.8 1688.8 1703.8 1714.2 1774.1 1866.2 53233.5 53603.0 54087.5 54226.5 54443.0 9542.7 9967.0 9977.0 9985.4 10007.5 13390.7 13460.7 13564.6 13565.3 13590.5 7224.3 7270.2 7292.5 7295.4 7313.3 6835.3 6849.2 6856.2 6896.7 6899.9 4432.8 4475.6 4534.8 4546.8 4559.7 1734.8 1786.2 1794.1 1840.8 1861.9 422.7 890.0 907.2 970.4 986.5 7964.8 10232.8 10647.7 10940.8 11258.6 447.0 451.0 476.1 479.9 481.8 5845.2 5858.5 5975.6 6158.9 6253.9 345326.0 359986.0 376700.0 526650.0 535725.0 61897.7 73543.0 74275.0 74383.6 77873.6 482.9 485.4 486.5 487.5 488.8 10221.2 10385.4 10449.4 10467.3 10772.8 32416.7 33341.5 33908.2 33952.5 34151.0 42711.8 43092.6 43280.4 43608.0 43833.8 4487.6 7130.0 7142.5 7333.3 7527.8 9237.3 9987.5 10218.8 10667.5 10940.9 8701.5 8932.0 9128.8 9539.8 9590.0 9150.0 9349.2 9557.2 10234.0 10421.0 9639.8 9773.9 9888.7 10199.4 10202.7 7467.6 7522.7 7548.5 7762.0 7814.2 7576.5 9895.2 9962.4 10095.5 10106.9 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#3] mootools.html Cycles:180 Average:5389.75 Median:6339.07 stddev:2734.81 (43.1%) stddev-sans-first:2725.18 05:49:54 INFO - PROCESS | 6720 | Values: 1297.5 1451.3 1477.6 1633.4 1782.7 6841.8 7388.5 7513.0 7547.4 7552.1 7479.4 7630.5 7641.3 7643.9 7662.1 2319.9 2343.9 2344.4 2346.4 2348.0 2253.5 2267.8 2276.1 2291.1 2295.3 2294.6 2322.2 2332.7 2340.6 2356.8 2305.5 2313.3 2319.7 2321.9 2324.6 2311.5 2318.4 2319.4 2321.3 2322.8 7695.8 7721.1 7730.3 7734.7 7741.4 4649.2 4721.2 4745.2 4775.9 4778.3 3086.6 3116.4 3146.5 3160.5 3162.9 1074.9 1084.9 1112.1 1152.3 1161.9 10381.3 10388.9 10396.3 10405.2 10408.1 4212.2 4216.9 4243.7 4416.8 4431.2 9143.0 9158.4 9171.6 9181.2 9198.6 4800.0 4802.0 4819.5 4844.3 4849.3 3835.6 3861.8 4234.9 4357.8 4455.5 3729.3 3740.0 3744.0 3794.2 3819.1 1141.6 1228.3 1234.4 1235.6 1239.7 969.6 1039.1 1121.7 1138.6 1312.4 6834.8 6921.0 6953.5 7015.6 7032.9 1103.2 1112.8 1114.3 1114.4 1126.9 5466.5 5505.5 5513.0 5524.2 5620.1 8869.2 8870.7 8877.9 8975.6 9188.6 8872.1 8936.2 8946.4 8948.5 8978.4 6944.2 7032.8 7219.5 7251.9 7303.4 7047.4 7078.0 7109.9 7118.8 7131.1 8176.3 8322.3 8350.2 8517.8 8547.1 8500.6 8577.7 8688.9 8844.0 8848.7 6923.0 6927.6 7021.6 7055.0 7056.1 7438.7 7491.6 7493.6 7495.1 7502.5 5844.9 6582.0 6665.5 6839.6 7237.6 6497.1 6503.6 6505.3 6609.0 6610.0 6662.9 6857.9 6890.0 6897.8 6946.7 6252.7 6483.7 6522.5 6523.1 6529.8 6425.5 6487.4 6508.3 6512.9 6613.8 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#4] prototype.html Cycles:180 Average:5180.15 Median:5795.08 stddev:1552.05 (26.8%) stddev-sans-first:1513.29 05:49:54 INFO - PROCESS | 6720 | Values: 339.8 341.0 343.1 349.2 351.4 5665.4 5784.7 5792.7 5875.5 5906.8 5636.5 5760.7 5763.5 5767.7 5781.3 4517.2 4520.0 4531.6 4539.0 4562.9 4352.7 4474.6 4483.0 4487.0 4555.4 4390.6 4448.9 4474.0 4517.0 4523.4 4487.4 4514.2 4522.0 4522.7 4537.4 4004.9 4006.3 4011.3 4013.1 4015.1 5451.5 5576.4 5598.2 5601.7 5602.4 5174.0 5186.1 5188.1 5190.4 5192.6 6156.1 6163.7 6166.5 6168.5 6173.6 4322.2 4326.7 4333.0 4337.0 4346.6 6191.9 6451.7 6456.4 6511.3 6527.2 4412.9 4418.7 4420.1 4421.8 4426.6 4465.0 4470.1 4473.8 4474.4 4481.2 5053.5 5131.2 5142.7 5147.6 5162.8 6172.9 6206.2 6258.6 6264.3 6277.9 1500.0 1506.5 1522.0 1524.0 1524.4 1028.9 1045.0 1045.2 1055.9 1075.6 5777.6 5794.6 5795.5 5806.2 5809.7 6089.7 6213.9 6226.1 6336.1 6348.7 5810.4 5815.8 5842.3 5867.8 5868.7 3387.6 3424.7 3425.7 3426.3 3429.3 6351.3 6501.9 6521.1 6571.6 6628.7 6536.9 6541.7 6542.8 6550.6 6550.6 6610.6 6617.8 6625.7 6627.3 6631.1 6205.7 6371.0 6371.2 6384.6 6400.2 6315.3 6317.0 6338.5 6340.8 6349.1 6623.7 6626.4 6630.0 6631.1 6632.0 4379.0 4452.7 4456.8 4457.1 4460.3 6353.6 6390.1 6423.3 6427.6 6436.2 6250.2 6267.0 6269.0 6269.7 6273.7 6134.4 6235.1 6235.9 6238.4 6244.2 6133.0 6145.9 6151.9 6152.4 6153.0 6239.6 6253.5 6265.2 6284.5 6289.8 5735.3 6109.0 6115.0 6163.0 6164.2 05:49:54 INFO - PROCESS | 6720 | 05:49:54 INFO - PROCESS | 6720 | [#5] yui.html Cycles:180 Average:13231.33 Median:44541.28 stddev:15267.58 (34.3%) stddev-sans-first:15281.73 05:49:54 INFO - PROCESS | 6720 | Values: 770.2 799.1 825.5 857.9 862.7 12854.6 12995.9 13010.3 13045.5 13051.3 12429.6 12547.3 12603.4 12635.7 13075.9 806.0 816.4 816.9 817.4 817.6 808.6 811.9 812.3 812.4 812.9 842.2 842.5 843.1 844.0 845.4 838.4 838.5 840.0 840.2 841.4 620.4 620.8 621.9 622.2 623.0 12368.8 12370.6 12388.3 12400.4 12410.0 10538.9 10615.5 10673.9 10842.7 11179.5 9435.6 9534.6 9547.7 9552.9 9579.7 3426.3 3479.3 3503.3 3565.6 3597.4 43919.4 43970.8 44031.6 49148.3 49181.8 10064.7 10077.4 10251.1 10342.9 10440.3 17525.6 17559.8 17562.0 17567.9 17581.1 6099.4 7376.2 7501.8 7518.4 7710.2 3962.1 3977.6 4047.1 4052.2 4120.6 2962.2 3021.5 3021.7 3022.3 3022.8 520.6 537.6 544.4 549.5 555.2 531.3 564.4 613.7 638.4 646.8 8290.2 8393.8 8442.7 8567.0 8623.5 681.0 684.3 685.8 719.0 733.7 3788.8 4137.9 4192.4 4217.5 4317.8 53007.7 53210.0 53720.0 53735.0 53746.2 49832.5 50016.7 52929.5 53078.7 54810.5 42540.4 43341.8 44222.8 44859.8 44908.0 8424.2 8768.4 8903.1 8917.0 9045.6 30742.4 31433.0 34899.7 35425.8 35936.5 39706.6 40709.8 41152.4 42677.0 42799.0 10880.2 10932.8 10963.5 11209.9 11348.4 11746.9 11937.6 12046.5 12117.2 12443.4 10517.4 10916.1 10936.2 11031.9 11281.2 10534.4 10720.8 10737.9 10747.2 10749.3 10731.4 10793.1 10827.6 11119.6 11395.9 8899.8 9010.1 9110.7 9255.5 9408.6 8196.5 8364.4 8808.5 9012.6 9555.3 05:49:54 INFO - PROCESS | 6720 | -------- Summary: end -------- 05:49:54 INFO - PROCESS | 6720 | 05:49:55 INFO - TEST-INFO | 6720: exit 0 05:49:55 INFO - TEST-OK | dromaeo_css | took 1111981ms 05:49:55 INFO - TEST-START | kraken 05:49:55 INFO - operating with platform_type : linux_ 05:49:55 INFO - Initialising browser for kraken test... 05:49:55 INFO - TEST-INFO | started process 6919 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEuXfKF/profile http://localhost:48106/getInfo.html) 05:49:58 INFO - PROCESS | 6919 | __metrics Screen width/height:1600/1200 05:49:58 INFO - PROCESS | 6919 | colorDepth:24 05:49:58 INFO - PROCESS | 6919 | Browser inner width/height: 1024/697 05:49:58 INFO - PROCESS | 6919 | __metrics 05:49:59 INFO - PROCESS | 6919 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:49:59 INFO - PROCESS | 6919 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:00 INFO - TEST-INFO | 6919: exit 0 05:50:00 INFO - Browser initialized. 05:50:00 INFO - Running cycle 1/1 for kraken test... 05:50:00 INFO - TEST-INFO | started process 7000 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEuXfKF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:11 INFO - PROCESS | 7000 | RSS: Main: 148434944 05:50:11 INFO - PROCESS | 7000 | 05:50:14 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:14 INFO - PROCESS | 7000 | RSS: Main: 187404288 05:50:14 INFO - PROCESS | 7000 | 05:50:17 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-dft) 05:50:18 INFO - PROCESS | 7000 | RSS: Main: 177352704 05:50:18 INFO - PROCESS | 7000 | 05:50:21 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-fft) 05:50:21 INFO - PROCESS | 7000 | RSS: Main: 162234368 05:50:21 INFO - PROCESS | 7000 | 05:50:23 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48106/tests/kraken/driver.html?testName=audio-oscillator) 05:50:24 INFO - PROCESS | 7000 | RSS: Main: 164683776 05:50:24 INFO - PROCESS | 7000 | 05:50:26 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:27 INFO - PROCESS | 7000 | RSS: Main: 165126144 05:50:27 INFO - PROCESS | 7000 | 05:50:29 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:30 INFO - PROCESS | 7000 | RSS: Main: 166092800 05:50:30 INFO - PROCESS | 7000 | 05:50:33 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48106/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:34 INFO - PROCESS | 7000 | RSS: Main: 168194048 05:50:34 INFO - PROCESS | 7000 | 05:50:37 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48106/tests/kraken/driver.html?testName=json-parse-financial) 05:50:37 INFO - PROCESS | 7000 | RSS: Main: 167104512 05:50:37 INFO - PROCESS | 7000 | 05:50:39 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:39 INFO - PROCESS | 7000 | RSS: Main: 179318784 05:50:39 INFO - PROCESS | 7000 | 05:50:41 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:42 INFO - PROCESS | 7000 | RSS: Main: 178094080 05:50:42 INFO - PROCESS | 7000 | 05:50:44 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:44 INFO - PROCESS | 7000 | RSS: Main: 187289600 05:50:44 INFO - PROCESS | 7000 | 05:50:47 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:47 INFO - PROCESS | 7000 | RSS: Main: 196202496 05:50:47 INFO - PROCESS | 7000 | 05:50:50 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:50 INFO - PROCESS | 7000 | RSS: Main: 195739648 05:50:50 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | Cycle 1(1): loaded http://localhost:48106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48106/tests/kraken/driver.html?testName=ai-astar) 05:50:52 INFO - PROCESS | 7000 | RSS: Main: 255451136 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | __start_tp_report 05:50:52 INFO - PROCESS | 7000 | _x_x_mozilla_page_load 05:50:52 INFO - PROCESS | 7000 | _x_x_mozilla_page_load_details 05:50:52 INFO - PROCESS | 7000 | |i|pagename|runs| 05:50:52 INFO - PROCESS | 7000 | |0;ai-astar;111;112;105;109;109;109;110;110;103;109 05:50:52 INFO - PROCESS | 7000 | |1;audio-beat-detection;151;122;147;168;128;149;153;128;166;128 05:50:52 INFO - PROCESS | 7000 | |2;audio-dft;161;161;161;159;159;161;158;159;161;161 05:50:52 INFO - PROCESS | 7000 | |3;audio-fft;73;75;92;98;72;72;72;120;97;72 05:50:52 INFO - PROCESS | 7000 | |4;audio-oscillator;97;96;144;97;97;96;139;96;97;138 05:50:52 INFO - PROCESS | 7000 | |5;imaging-gaussian-blur;109;110;109;109;109;110;110;110;109;109 05:50:52 INFO - PROCESS | 7000 | |6;imaging-darkroom;146;146;147;146;146;146;148;146;146;146 05:50:52 INFO - PROCESS | 7000 | |7;imaging-desaturate;96;96;95;96;95;97;97;96;96;97 05:50:52 INFO - PROCESS | 7000 | |8;json-parse-financial;55;55;55;55;55;58;57;56;55;54 05:50:52 INFO - PROCESS | 7000 | |9;json-stringify-tinderbox;67;67;67;67;69;68;67;68;68;68 05:50:52 INFO - PROCESS | 7000 | |10;stanford-crypto-aes;81;82;82;93;87;82;83;83;82;84 05:50:52 INFO - PROCESS | 7000 | |11;stanford-crypto-ccm;119;114;123;118;112;113;123;113;128;116 05:50:52 INFO - PROCESS | 7000 | |12;stanford-crypto-pbkdf2;144;130;140;139;138;129;140;139;139;139 05:50:52 INFO - PROCESS | 7000 | |13;stanford-crypto-sha256-iterative;66;68;66;66;65;67;69;66;68;65 05:50:52 INFO - PROCESS | 7000 | __end_tp_report 05:50:52 INFO - PROCESS | 7000 | __start_cc_report 05:50:52 INFO - PROCESS | 7000 | _x_x_mozilla_cycle_collect,920 05:50:52 INFO - PROCESS | 7000 | __end_cc_report 05:50:52 INFO - PROCESS | 7000 | __startTimestamp1453557052910__endTimestamp 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | ------- Summary: start ------- 05:50:52 INFO - PROCESS | 7000 | Number of tests: 14 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.50 stddev:2.71 (2.5%) stddev-sans-first:2.74 05:50:52 INFO - PROCESS | 7000 | Values: 111.0 112.0 105.0 109.0 109.0 109.0 110.0 110.0 103.0 109.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.00 stddev:16.59 (11.1%) stddev-sans-first:17.40 05:50:52 INFO - PROCESS | 7000 | Values: 151.0 122.0 147.0 168.0 128.0 149.0 153.0 128.0 166.0 128.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#2] audio-dft Cycles:10 Average:160.10 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 05:50:52 INFO - PROCESS | 7000 | Values: 161.0 161.0 161.0 159.0 159.0 161.0 158.0 159.0 161.0 161.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#3] audio-fft Cycles:10 Average:84.30 Median:74.00 stddev:16.67 (22.5%) stddev-sans-first:17.18 05:50:52 INFO - PROCESS | 7000 | Values: 73.0 75.0 92.0 98.0 72.0 72.0 72.0 120.0 97.0 72.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.50 stddev:21.20 (22.0%) stddev-sans-first:21.98 05:50:52 INFO - PROCESS | 7000 | Values: 97.0 96.0 144.0 97.0 97.0 96.0 139.0 96.0 97.0 138.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:50:52 INFO - PROCESS | 7000 | Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:50:52 INFO - PROCESS | 7000 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:50:52 INFO - PROCESS | 7000 | Values: 96.0 96.0 95.0 96.0 95.0 97.0 97.0 96.0 96.0 97.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:1.18 (2.1%) stddev-sans-first:1.24 05:50:52 INFO - PROCESS | 7000 | Values: 55.0 55.0 55.0 55.0 55.0 58.0 57.0 56.0 55.0 54.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:50:52 INFO - PROCESS | 7000 | Values: 67.0 67.0 67.0 67.0 69.0 68.0 67.0 68.0 68.0 68.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.60 (4.3%) stddev-sans-first:3.67 05:50:52 INFO - PROCESS | 7000 | Values: 81.0 82.0 82.0 93.0 87.0 82.0 83.0 83.0 82.0 84.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.50 stddev:5.34 (4.5%) stddev-sans-first:5.65 05:50:52 INFO - PROCESS | 7000 | Values: 119.0 114.0 123.0 118.0 112.0 113.0 123.0 113.0 128.0 116.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.70 Median:139.00 stddev:4.62 (3.3%) stddev-sans-first:4.30 05:50:52 INFO - PROCESS | 7000 | Values: 144.0 130.0 140.0 139.0 138.0 129.0 140.0 139.0 139.0 139.0 05:50:52 INFO - PROCESS | 7000 | 05:50:52 INFO - PROCESS | 7000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 05:50:52 INFO - PROCESS | 7000 | Values: 66.0 68.0 66.0 66.0 65.0 67.0 69.0 66.0 68.0 65.0 05:50:52 INFO - PROCESS | 7000 | -------- Summary: end -------- 05:50:52 INFO - PROCESS | 7000 | 05:50:53 INFO - TEST-INFO | 7000: exit 0 05:50:53 INFO - TEST-OK | kraken | took 58772ms 05:50:53 INFO - TEST-START | v8_7 05:50:53 INFO - operating with platform_type : linux_ 05:50:53 INFO - Initialising browser for v8_7 test... 05:50:53 INFO - TEST-INFO | started process 7250 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkwVPCp/profile http://localhost:48106/getInfo.html) 05:50:57 INFO - PROCESS | 7250 | __metrics Screen width/height:1600/1200 05:50:57 INFO - PROCESS | 7250 | colorDepth:24 05:50:57 INFO - PROCESS | 7250 | Browser inner width/height: 1024/697 05:50:57 INFO - PROCESS | 7250 | __metrics 05:50:58 INFO - PROCESS | 7250 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:50:58 INFO - PROCESS | 7250 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:58 INFO - TEST-INFO | 7250: exit 0 05:50:58 INFO - Browser initialized. 05:50:58 INFO - Running cycle 1/1 for v8_7 test... 05:50:58 INFO - TEST-INFO | started process 7330 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkwVPCp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:10 INFO - PROCESS | 7330 | RSS: Main: 148480000 05:51:10 INFO - PROCESS | 7330 | 05:51:32 INFO - PROCESS | 7330 | Cycle 1(1): loaded http://localhost:48106/tests/v8_7/run.html (next: http://localhost:48106/tests/v8_7/run.html) 05:51:33 INFO - PROCESS | 7330 | RSS: Main: 542670848 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | __start_tp_report 05:51:33 INFO - PROCESS | 7330 | _x_x_mozilla_page_load 05:51:33 INFO - PROCESS | 7330 | _x_x_mozilla_page_load_details 05:51:33 INFO - PROCESS | 7330 | |i|pagename|runs| 05:51:33 INFO - PROCESS | 7330 | |0;Richards;168.74789065136684 05:51:33 INFO - PROCESS | 7330 | |1;DeltaBlue;189.78933383943823 05:51:33 INFO - PROCESS | 7330 | |2;Encrypt;279.4076557697681 05:51:33 INFO - PROCESS | 7330 | |3;Decrypt;5235.602094240838 05:51:33 INFO - PROCESS | 7330 | |4;RayTrace;1122.334455667789 05:51:33 INFO - PROCESS | 7330 | |5;Earley;780.0312012480499 05:51:33 INFO - PROCESS | 7330 | |6;Boyer;12180.722891566265 05:51:33 INFO - PROCESS | 7330 | |7;RegExp;42479.166666666664 05:51:33 INFO - PROCESS | 7330 | |8;Splay;593.8242280285035 05:51:33 INFO - PROCESS | 7330 | |9;NavierStokes;4830.917874396136 05:51:33 INFO - PROCESS | 7330 | __end_tp_report 05:51:33 INFO - PROCESS | 7330 | __startTimestamp1453557093241__endTimestamp 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | ------- Summary: start ------- 05:51:33 INFO - PROCESS | 7330 | Number of tests: 10 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#0] Richards Cycles:1 Average:168.75 Median:168.75 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 168.7 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#1] DeltaBlue Cycles:1 Average:189.79 Median:189.79 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 189.8 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 279.4 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 5235.6 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#4] RayTrace Cycles:1 Average:1122.33 Median:1122.33 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 1122.3 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 780.0 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 12180.7 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#7] RegExp Cycles:1 Average:42479.17 Median:42479.17 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 42479.2 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#8] Splay Cycles:1 Average:593.82 Median:593.82 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 593.8 05:51:33 INFO - PROCESS | 7330 | 05:51:33 INFO - PROCESS | 7330 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:51:33 INFO - PROCESS | 7330 | Values: 4830.9 05:51:33 INFO - PROCESS | 7330 | -------- Summary: end -------- 05:51:33 INFO - PROCESS | 7330 | 05:51:34 INFO - TEST-INFO | 7330: exit 0 05:51:34 INFO - TEST-OK | v8_7 | took 40331ms 05:51:34 INFO - SUITE-END | took 1211s 05:51:34 INFO - Completed test suite (00:20:11) 05:51:34 INFO - Working with test: dromaeo_css 05:51:34 INFO - Generating results file: dromaeo_css 05:51:34 INFO - Working with test: kraken 05:51:34 INFO - Generating results file: kraken 05:51:34 INFO - javascript benchmark 05:51:34 INFO - Working with test: v8_7 05:51:34 INFO - Generating results file: v8_7 05:51:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:51:34 INFO - process_Request line: dromaeo_css 6658.74 graph.html#tests=[[72,1,35]] 05:51:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:34 INFO - process_Request line: kraken 1487.80 graph.html#tests=[[232,1,35]] 05:51:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:34 INFO - process_Request line: v8_7 20030.01 graph.html#tests=[[230,1,35]] 05:51:34 INFO - RETURN: dromaeo_css: 6658.74 05:51:34 INFO - RETURN: kraken: 1487.80 05:51:34 INFO - RETURN: v8_7: 20030.01 05:51:34 INFO - javascript benchmark 05:51:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3086.845657717114, 3128.7653425993058, 3169.0809665197094, 3172.4606816841133, 3185.872565097396, 5018.698878067318, 5102.6428150029515, 5111.74441277936, 5135.05001574709, 5167.819126330579, 5068.873278168047, 5082.390113186413, 5086.898262034757, 5092.9236061459105, 5099.413567439737, 4662.766861656912, 4671.346011558385, 4687.460941991681, 4733.0, 4781.856544303659, 4700.036492519025, 4703.623710103184, 4757.04859028194, 4757.310190022445, 4767.618590512768, 4622.214223581999, 4649.20963436215, 4658.906821863544, 4683.88290292742, 4697.295405689139, 4647.55848194421, 4654.930176047362, 4678.485366609671, 4699.953000469985, 4709.0, 4656.301554766778, 4686.08621318843, 4686.953130468686, 4688.249880019181, 4695.765211739399, 4932.383452068491, 4980.526849949249, 4991.450940396553, 4992.750362481861, 4997.450280469146, 5434.103372943459, 5436.972815135939, 5446.863828404282, 5453.072977593819, 5458.372287186945, 5482.479164479368, 5488.9725551372385, 5493.148561972901, 5493.983613031602, 5577.079781836032, 5179.404368497596, 5184.092783762864, 5184.222366644995, 5185.066687996159, 5186.688798672054, 5579.442055794388, 5588.050031494656, 5623.465770751772, 5630.971845140748, 5631.774729010794, 5240.816571420059, 5307.62846600742, 5389.730513474311, 5419.078756611386, 5488.423715509894, 5483.177523371526, 5485.204645326485, 5498.120300751861, 5498.3127109111365, 5503.862403439946, 5432.538234250133, 5457.072297709319, 5473.042217611902, 5481.342238931354, 5525.281713377235, 5376.569874410038, 5461.535769459561, 5463.808766693147, 5473.917891231635, 5551.694656793915, 4276.102018576072, 4290.227759003347, 4295.570442955679, 4303.376010478463, 4318.762468064224, 3769.5099637047556, 3832.2335532893535, 3833.022579242331, 3862.497875276252, 3871.5741268460447, 5067.619928505377, 5105.693658380509, 5110.259012443249, 5110.872228194325, 5153.793848246029, 5469.0, 5517.2551705520045, 5520.779168833202, 5523.005858945428, 5525.861853453615, 4949.579285760678, 5040.697558146523, 5128.769205385692, 5136.563392111638, 5163.044836705221, 4596.287575425815, 4625.560571745679, 4649.5350464953235, 4652.0, 4682.742449165328, 5701.800436984686, 5704.971475142681, 5706.80026199081, 5712.143178523254, 5747.195392645033, 5386.434424385383, 5454.481824226692, 5513.173024046425, 5522.475364840334, 5529.778808847601, 5657.377688454185, 5672.319321681424, 5676.914846277392, 5680.602357835077, 5730.341010783646, 5430.104032834696, 5434.972825135849, 5435.184722291688, 5441.918371224356, 5443.401225865231, 5391.514763671288, 5500.0, 5511.311086114236, 5558.666480011212, 5563.8887222256135, 5429.185622156708, 5441.183822426668, 5445.074337362737, 5454.400015998316, 5469.644473109235, 5378.139497680352, 5406.918896216481, 5408.75660595282, 5417.891642167214, 5453.563714902878, 5150.072986862401, 5253.763580638957, 5290.391604965324, 5344.064788661891, 5375.946240537544, 5456.263404440349, 5459.535939445192, 5462.535684466865, 5474.8905021898545, 5531.502164805187, 5300.522952934254, 5340.546053585489, 5346.759395827119, 5353.384360798558, 5354.437784032621], "unit": "score", "name": "dojo.html", "value": 5074.519200705661}, {"lowerIsBetter": false, "replicates": [503.9269305950635, 541.3044238153972, 547.0563278344858, 564.991525127123, 581.9883602327951, 28027.299317517074, 28218.294542636446, 28404.857975710143, 28410.715892841064, 34534.136646583785, 37345.25309493808, 38124.61875381245, 38442.42336364957, 38479.23041539174, 38484.230315393674, 8380.958095209531, 8579.742607721779, 8580.0, 8590.398672092955, 8593.44142630727, 8282.627281772304, 8396.202360775716, 8419.621117049748, 8423.15768423159, 8424.705135320264, 8421.578921053953, 8733.12668733128, 8739.344549158839, 8741.0, 8751.343649226334, 8591.26974207193, 8631.95684021579, 8644.265237454823, 8644.870326945102, 8647.827043459127, 8460.957695211546, 8601.0, 8610.655573777041, 8613.267872230805, 8618.525981071101, 37336.81331593324, 37922.62077379246, 37935.24129517394, 38128.42807357892, 38223.808880955694, 3117.719405253538, 3232.9838350808095, 3266.3467306538787, 3852.672522835562, 3901.648851603369, 30979.690203097907, 31079.0, 31719.207019824687, 33160.50259246113, 34026.0, 3950.1309711863346, 3995.860144894944, 4063.634272915422, 4080.3063479208604, 4094.9795251023556, 256529.0, 258315.9999999981, 258711.0, 258902.0, 259289.0, 56286.718566406904, 57417.42582574121, 61754.0, 62540.0, 62716.0, 68701.0, 70240.64879675569, 70334.64832675907, 70386.64806676036, 70402.0, 15577.688446231012, 15900.68198636044, 15915.681686366208, 15929.601759955862, 15936.28286727077, 11076.556937722562, 11275.887241127484, 11306.491207895664, 11360.545578176945, 11949.820752688716, 20672.069756860976, 20958.685619715718, 20975.0, 21071.894640526698, 21153.68269475959, 8271.8345633087, 8443.155684431631, 8463.31384248802, 8547.35894807892, 8683.131686831266, 907.9909200908038, 942.6559305853314, 978.4520668425704, 997.5211898288717, 1022.9386236825815, 27053.32366690809, 28296.0, 28350.0, 28618.427631447255, 28738.71261287402, 967.8451447768323, 1021.8927012663712, 1070.4326706845384, 1094.4473041114186, 1114.8160553508742, 14619.634509137357, 14671.486497972519, 14719.926400368144, 14985.475508357154, 15000.399984000736, 301606.0, 308191.0, 308746.0, 309014.0, 309429.0, 48393.75803120962, 48905.0, 48978.51021489811, 49309.50690493121, 49358.506414936106, 1266.1896386312767, 1331.973360532784, 1339.3838834136407, 1349.291621898511, 1351.797230415426, 26733.732662673123, 27580.862095689394, 27886.442271154057, 28100.578491322238, 28130.71869281281, 41604.58395416007, 42034.0, 44169.55830441655, 44518.551479667636, 46682.0, 233370.0, 238624.0, 239221.80389097944, 239245.0, 240438.0, 32289.0, 32368.190795230308, 32491.83754081309, 32672.673273266962, 32694.509582355808, 32363.51454728134, 35481.82259088688, 35815.82092089523, 38283.61716382801, 44381.778091109336, 32652.0, 34390.82804585961, 34538.82730586331, 34565.30869382548, 35518.46722299219, 34460.82769586136, 34781.30437391187, 35227.64772352346, 35231.0, 35361.469577956865, 33414.498782517796, 33541.40948687329, 33702.0, 33878.66121338755, 33898.66101338955, 29891.701082988893, 30932.690673093883, 31169.220769480944, 31280.21799455032, 31425.371492570477, 23603.763962360845, 23825.880870595534, 23944.40138996539, 24148.0, 26163.345916352242], "unit": "score", "name": "ext.html", "value": 18002.43410003943}, {"lowerIsBetter": false, "replicates": [364.6699736738251, 368.97601655892356, 370.77197523523023, 372.1923426165222, 374.93251214781327, 13539.0, 13558.050936434454, 15687.52937411878, 16253.431129910456, 16979.32082716693, 15289.311980960856, 15413.0, 15892.76160857588, 15909.204539773023, 15935.681286374265, 4670.719756814594, 5357.919631205535, 5376.51611354978, 5378.515933565978, 5378.8924221515545, 3952.9209415811665, 4075.0219947212604, 5295.549878260353, 5375.43557926418, 5746.396628354005, 5716.7141642917895, 5884.293884733838, 5936.347001829795, 5938.198343223674, 5939.1388248703915, 5696.3733989261145, 5729.197912292282, 5747.827565173052, 5750.0, 5751.424857514278, 4978.576820970222, 5093.312402825608, 5099.286099946011, 5159.871003224912, 5161.148410512261, 19351.322703705442, 19507.707384389247, 19580.902095489575, 19650.70523942142, 19805.801941980684, 2097.119209931817, 2103.22180793106, 2114.3339847948, 2115.841311901598, 2227.4343348192833, 12028.0, 12338.629841104781, 12348.876511234863, 12389.380530973505, 13205.801912971314, 1688.8480036796625, 1703.7699910512047, 1714.2457318779698, 1774.0952114421739, 1866.150901339887, 53233.46766532324, 53603.0, 54087.45912540903, 54226.45773542253, 54443.0, 9542.666006689733, 9967.00329967012, 9977.0, 9985.400875947322, 10007.549660265306, 13390.732185356239, 13460.730785384434, 13564.593062208149, 13565.25391103479, 13590.524331648543, 7224.313690199528, 7270.236625154388, 7292.489525733148, 7295.379892709073, 7313.268673132644, 6835.282295359015, 6849.2465828758795, 6856.177258728984, 6896.689648965808, 6899.93100069003, 4432.778361081933, 4475.597196252353, 4534.77326133692, 4546.772661366918, 4559.700485361723, 1734.843864052216, 1786.2319202742685, 1794.1251392295082, 1840.7694496159422, 1861.9255229790656, 422.66820545871957, 889.973300800977, 907.1563445995288, 970.3547141151197, 986.4771671014374, 7964.800879977931, 10232.846507302396, 10647.733806654896, 10940.835887461695, 11258.605948791917, 447.03663604931427, 450.9932351014737, 476.1025466994671, 479.8968221832323, 481.8434008947106, 5845.181674565564, 5858.53131749459, 5975.611585246945, 6158.860610787019, 6253.906191407133, 345326.0, 359986.0, 376700.0, 526650.0, 535725.0, 61897.69051154715, 73543.0, 74275.0, 74383.62808185925, 77873.61063194647, 482.8985912958318, 485.3617492996698, 486.48918635432653, 487.4516169309527, 488.8044782087122, 10221.182305415401, 10385.428801415994, 10449.373037617766, 10467.267291289842, 10772.784544308914, 32416.67583324231, 33341.49987750234, 33908.15229619181, 33952.490712639825, 34151.0, 42711.7864410676, 43092.56907431011, 43280.35079473873, 43608.0, 43833.78083109564, 4487.6312724618, 7130.0, 7142.535735177197, 7333.339999400079, 7527.8118047049265, 9237.307201960015, 9987.500624968869, 10218.846717299395, 10667.46662666848, 10940.890591093987, 8701.477911325088, 8932.0, 9128.771780705536, 9539.76150596213, 9589.952050239704, 9150.0, 9349.205317548085, 9557.23542116643, 10234.0, 10421.0, 9639.759006024906, 9773.9022609773, 9888.703338899844, 10199.439030853375, 10202.693919182437, 7467.58928258951, 7522.699092036257, 7548.509346892434, 7761.953458209798, 7814.21857814214, 7576.469647124648, 9895.208383329173, 9962.352447090916, 10095.545700443645, 10106.898931010595], "unit": "score", "name": "jquery.html", "value": 7454.119030561862}, {"lowerIsBetter": false, "replicates": [1297.5134324628264, 1451.2671101093947, 1477.593661743021, 1633.428300094966, 1782.74150248214, 6841.8289542761395, 7388.482806203561, 7513.0233069700935, 7547.358474529671, 7552.055993000875, 7479.439042071839, 7630.465867389271, 7641.274078962503, 7643.9235607643905, 7662.118856331524, 2319.93040208794, 2343.9179628713, 2344.4373350395867, 2346.3664810501155, 2348.037304705071, 2253.5154941687533, 2267.8299127565415, 2276.123692378438, 2291.140822191678, 2295.2540424362064, 2294.5869743446174, 2322.245270287155, 2332.696749422581, 2340.625499920013, 2356.799672027871, 2305.4697419593585, 2313.2713195343413, 2319.652052192176, 2321.8839058047115, 2324.639680849471, 2311.4914718761847, 2318.3508617587104, 2319.3969567912295, 2321.280403075052, 2322.825788065885, 7695.846083078307, 7721.0734711834375, 7730.342920851735, 7734.729284475073, 7741.380689544823, 4649.18639238132, 4721.220998535237, 4745.1695953208055, 4775.904481910342, 4778.331033655291, 3086.5678804967324, 3116.40788250234, 3146.5437511560694, 3160.4943209086664, 3162.8734850605947, 1074.897884700952, 1084.902358787705, 1112.1214240749798, 1152.3489228585906, 1161.9302841829517, 10381.273310868242, 10388.896111038945, 10396.272260941661, 10405.219608529314, 10408.063274305274, 4212.241796476603, 4216.873493795191, 4243.745375277494, 4416.823327066945, 4431.224535706238, 9143.0, 9158.40470369424, 9171.633134674672, 9181.173694367539, 9198.586063627154, 4799.9760001199775, 4802.039592081597, 4819.542143496362, 4844.273358996108, 4849.345338379344, 3835.5972622874756, 3861.806909654506, 4234.9364759528635, 4357.782110894443, 4455.465344158722, 3729.272791805626, 3740.0, 3743.9625603743616, 3794.1842503861803, 3819.0834199792407, 1141.577616281981, 1228.2937311046005, 1234.3766397968968, 1235.6416639174538, 1239.69007748063, 969.5927710361665, 1039.0804138337473, 1121.685927940178, 1138.5901075612774, 1312.4422120598708, 6834.760783372558, 6921.0, 6953.513254072268, 7015.649217539102, 7032.859342813115, 1103.2387652519735, 1112.844201811747, 1114.3202646385698, 1114.3982249585133, 1126.921115521922, 5466.453354664502, 5505.476979687003, 5513.035218836688, 5524.171374293888, 5620.072688006515, 8869.246114080375, 8870.73387798367, 8877.911220887838, 8975.551222438851, 9188.586513606904, 8872.112788721077, 8936.151065648754, 8946.418482798597, 8948.463092214357, 8978.371513993958, 6944.236134025253, 7032.789016329519, 7219.494635375473, 7251.948467472293, 7303.3792127668685, 7047.365737083687, 7078.044463997295, 7109.893351599627, 7118.786436406709, 7131.144262688511, 8176.345892328718, 8322.334213262804, 8350.248477637042, 8517.787055323666, 8547.102554231717, 8500.61747221389, 8577.699780507652, 8688.913110869064, 8843.955780221058, 8848.690295839871, 6922.965385173244, 6927.58434493932, 7021.613811240431, 7055.0, 7056.1179852518435, 7438.73964411243, 7491.625418728932, 7493.587852668155, 7495.1005879294835, 7502.512336698097, 5844.883102338014, 6582.0, 6665.533412661067, 6839.62382068991, 7237.601931893796, 6497.122888410193, 6503.642299673564, 6505.349465053646, 6609.041688955171, 6610.0, 6662.933370666426, 6857.931420685929, 6890.0, 6897.7585784497305, 6946.687399067156, 6252.687365631791, 6483.675816209265, 6522.543421960418, 6523.054157147092, 6529.804105876831, 6425.453836423956, 6487.416132548094, 6508.251551071498, 6512.869742605216, 6613.834654133492], "unit": "score", "name": "mootools.html", "value": 4469.030421647479}, {"lowerIsBetter": false, "replicates": [339.7740502565791, 340.9829508524574, 343.09594219232315, 349.15852794764623, 351.37279955279814, 5665.3768085510565, 5784.652920824754, 5792.68140252286, 5875.47120759131, 5906.822795316142, 5636.4927156555905, 5760.683162426065, 5763.510101641355, 5767.711614419283, 5781.306243250805, 4517.232070548015, 4519.954800451987, 4531.569500897418, 4539.046800171951, 4562.931556026662, 4352.738835669854, 4474.552544745516, 4483.0, 4487.0, 4555.430571178603, 4390.648748100144, 4448.933266001012, 4474.0380818124095, 4516.954830451703, 4523.389342438778, 4487.39420178275, 4514.210013247669, 4521.977390113061, 4522.728636281834, 4537.4328208973875, 4004.8586152946273, 4006.278869803434, 4011.2579172853116, 4013.0569316210667, 4015.0966032642714, 5451.482109199659, 5576.358718747356, 5598.1602759585985, 5601.719914004283, 5602.38373778884, 5173.9741301293625, 5186.092433824066, 5188.066148093341, 5190.377154741417, 5192.55863251624, 6156.107364432132, 6163.660998645073, 6166.537509686791, 6168.475679567242, 6173.629582225081, 4322.157179350028, 4326.675499337531, 4332.981749288914, 4337.0458499130145, 4346.630536404409, 6191.938080619181, 6451.677416129175, 6456.354364563553, 6511.251206111263, 6527.15147030883, 4412.867613971586, 4418.734875907456, 4420.071784925201, 4421.801018954155, 4426.579474949875, 4465.0, 4470.083632855257, 4473.843415480507, 4474.351219073216, 4481.170983368087, 5053.545180933734, 5131.229725744613, 5142.71715055668, 5147.56245719118, 5162.845114646567, 6172.938270617326, 6206.162168107338, 6258.593191442542, 6264.342244064399, 6277.937220627735, 1499.9550013499613, 1506.4727345429012, 1521.9847801522064, 1523.9542813715607, 1524.3750062474332, 1028.861103750999, 1044.996803069047, 1045.1586472889396, 1055.904968552834, 1075.5912753153752, 5777.566682498829, 5794.62334948227, 5795.536357091422, 5806.187133801272, 5809.738561764731, 6089.725962331706, 6213.906791398133, 6226.128342032119, 6336.081268216083, 6348.746050158034, 5810.389909059488, 5815.767369305265, 5842.328132264844, 5867.765289388462, 5868.735906884201, 3387.5934887813128, 3424.7260219182403, 3425.7088147507243, 3426.280481098997, 3429.2969941162, 6351.301356850835, 6501.934980650228, 6521.0544471051435, 6571.638559879252, 6628.674265146893, 6536.934630653727, 6541.705623246965, 6542.836429089216, 6550.6069635822005, 6550.6069635822005, 6610.603363798187, 6617.7683781067435, 6625.701843416961, 6627.3372662733345, 6631.104800851823, 6205.720742566686, 6371.0, 6371.171747672773, 6384.553081284451, 6400.167978162809, 6315.336889626523, 6316.968415157895, 6338.492920566251, 6340.809775706736, 6349.111124442674, 6623.701933413105, 6626.403623673892, 6629.966850165718, 6631.104800851823, 6631.966840165768, 4378.956210437982, 4452.732836029849, 4456.777161141865, 4457.064016556559, 4460.286354183315, 6353.618782873043, 6390.073439351361, 6423.29343772194, 6427.646479443675, 6436.16329877113, 6250.156228909221, 6267.0286105653695, 6268.968655156695, 6269.749210031548, 6273.686315684289, 6134.386561344008, 6235.127082208585, 6235.875282494234, 6238.438540531374, 6244.188255526752, 6132.969335153296, 6145.877082458415, 6151.9384806151365, 6152.354002829638, 6152.969235153974, 6239.594426362272, 6253.468455181179, 6265.185525881606, 6284.465820405317, 6289.842753931189, 5735.340435849764, 6109.0, 6114.969425152845, 6162.969185154046, 6164.198654174928], "unit": "score", "name": "prototype.html", "value": 4678.174672598411}, {"lowerIsBetter": false, "replicates": [770.2259229474379, 799.0571126071236, 825.5289628858826, 857.9227869491745, 862.7023676831495, 12854.550090746825, 12995.935020324885, 13010.284434356106, 13045.478180872766, 13051.282179480124, 12429.627111186655, 12547.309897955609, 12603.369831508411, 12635.684107897285, 13075.934620326885, 805.9677612895492, 816.3754727633366, 816.8693009118542, 817.3787921179917, 817.5503473089807, 808.640155130967, 811.922867327603, 812.273015650992, 812.3907069697726, 812.8943237379133, 842.2335674536173, 842.5366048673236, 843.1231519220034, 844.0209357145712, 845.4293351987415, 838.3712215838121, 838.4550042472441, 840.0129847429276, 840.2311884625591, 841.4110122913924, 620.3982137326785, 620.8168590265838, 621.8973869311558, 622.1942584353274, 623.0436280309702, 12368.75262494745, 12370.567030153992, 12388.31864247466, 12400.379981000913, 12410.0, 10538.894611053867, 10615.469226538642, 10673.893261067367, 10842.674719758419, 11179.4969226385, 9435.575399107056, 9534.618615255382, 9547.713568592953, 9552.856707149398, 9579.664711735057, 3426.2804810989724, 3479.2519608284088, 3503.2643144939593, 3565.625609311011, 3597.37046016946, 43919.388464211435, 43970.78014609939, 44031.559684403386, 49148.262776058385, 49181.75409122931, 10064.718028452171, 10077.395356278501, 10251.12865406434, 10342.948285258675, 10440.269181157246, 17525.64948701019, 17559.824401756076, 17562.03408812502, 17567.912160439115, 17581.120943952752, 6099.390060993954, 7376.225496322809, 7501.774946751606, 7518.398528117737, 7710.228977102245, 3962.148138150254, 3977.622125898035, 4047.069174089917, 4052.1895620875944, 4120.62914337711, 2962.229820246708, 3021.5165573508134, 3021.7129372709555, 3022.30486987994, 3022.818630882154, 520.6173462505132, 537.5592014548033, 544.3685325022955, 549.4697616799727, 555.2060553408584, 531.3066448285025, 564.3594520219498, 613.7054213977316, 638.3680156644888, 646.767163821024, 8290.165704267982, 8393.832123357499, 8442.704505342284, 8567.0, 8623.525706086226, 680.9727610895509, 684.3225207045089, 685.8388278754488, 719.0113593808513, 733.7142178170709, 3788.8295026723863, 4137.937930931039, 4192.434021407132, 4217.506368385059, 4317.8272869084885, 53007.73496132572, 53210.0, 53720.0, 53735.0, 53746.193807092925, 49832.501674982785, 50016.74991625091, 52929.47070529246, 53078.734606327496, 54810.45189548133, 42540.36189457161, 43341.783291083346, 44222.778886106, 44859.77570112129, 44908.0, 8424.157584241771, 8768.386212965032, 8903.065178156201, 8917.0, 9045.63817447321, 30742.38515229638, 31433.0, 34899.65100348964, 35425.82287088548, 35936.4609530852, 39706.602933971444, 40709.79645101756, 41152.38271425991, 42677.0, 42799.0, 10880.238383313408, 10932.836007460053, 10963.506642201279, 11209.887901120885, 11348.375839328586, 11746.941265293619, 11937.641870743892, 12046.51813927433, 12117.212381195193, 12443.44004519817, 10517.368957862553, 10916.12670986335, 10936.234463587472, 11031.889681103086, 11281.21031527818, 10534.36793792375, 10720.785584288427, 10737.892621074001, 10747.193960453154, 10749.301295415773, 10731.356118632906, 10793.08258798011, 10827.621033263798, 11119.610813621484, 11395.943020284845, 8899.777505562413, 9010.074115285957, 9110.726678199664, 9255.53722313895, 9408.623655053721, 8196.508209507449, 8364.414490985573, 8808.515531645564, 9012.63949442015, 9555.283353748358], "unit": "score", "name": "yui.html", "value": 6122.119191181681}], "name": "dromaeo_css", "value": 6658.737990497719}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 109.0, 109.0, 109.0, 110.0, 110.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [151.0, 122.0, 147.0, 168.0, 128.0, 149.0, 153.0, 128.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 159.0, 159.0, 161.0, 158.0, 159.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 92.0, 98.0, 72.0, 72.0, 72.0, 120.0, 97.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 144.0, 97.0, 97.0, 96.0, 139.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 58.0, 57.0, 56.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 93.0, 87.0, 82.0, 83.0, 83.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 123.0, 118.0, 112.0, 113.0, 123.0, 113.0, 128.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [144.0, 130.0, 140.0, 139.0, 138.0, 129.0, 140.0, 139.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 66.0, 65.0, 67.0, 69.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1487.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.74789065136684], "unit": "score", "name": "Richards", "value": 209.19965200000001}, {"lowerIsBetter": false, "replicates": [189.78933383943823], "unit": "score", "name": "DeltaBlue", "value": 348.37574199999995}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [1122.334455667789], "unit": "score", "name": "RayTrace", "value": 659.3301990000002}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [42479.166666666664], "unit": "score", "name": "RegExp", "value": 21.445453653751855}, {"lowerIsBetter": false, "replicates": [593.8242280285035], "unit": "score", "name": "Splay", "value": 137.23084400000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20030.01033788452}]} 05:51:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20030.01"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1487.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6658.74"}}} 05:51:34 INFO - Return code: 0 05:51:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:34 INFO - # TBPL SUCCESS # 05:51:34 INFO - Running post-action listener: _resource_record_post_action 05:51:34 INFO - Running post-run listener: _resource_record_post_run 05:51:35 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 537911296; Read time: 0; Write time: 539872 05:51:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236204032; Read time: 0; Write time: 277528 05:51:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 301707264; Read time: 0; Write time: 262344 05:51:35 INFO - Running post-run listener: _upload_blobber_files 05:51:35 INFO - Blob upload gear active. 05:51:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:51:35 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 05:51:35 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'] 05:51:35 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 05:51:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:37 INFO - (blobuploader) - INFO - Done attempting. 05:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:37 INFO - (blobuploader) - INFO - Done attempting. 05:51:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:37 INFO - Return code: 0 05:51:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:51:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ed158d58c20794bb0e05d1019a77b4535bf292f381b63fa1f2df102e6aa76f0f5d473d5ca68b25fa0b1a3c07d86a76fb067c262388b3989923008c6ff2a570f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b96082f312de6a9d0195ac49836bc420e1dc898eb893e37217cb2ef854af8e57f4de9e1ee8a2017b377d2f29d3688f5d055a3f7bad99381498b786a5c62b678"} 05:51:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:51:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:51:37 INFO - Contents: 05:51:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ed158d58c20794bb0e05d1019a77b4535bf292f381b63fa1f2df102e6aa76f0f5d473d5ca68b25fa0b1a3c07d86a76fb067c262388b3989923008c6ff2a570f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b96082f312de6a9d0195ac49836bc420e1dc898eb893e37217cb2ef854af8e57f4de9e1ee8a2017b377d2f29d3688f5d055a3f7bad99381498b786a5c62b678"} 05:51:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:37 INFO - Copying logs to upload dir... 05:51:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:51:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.994568 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-23 05:51:37.328710) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:37.332425) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 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/9ed158d58c20794bb0e05d1019a77b4535bf292f381b63fa1f2df102e6aa76f0f5d473d5ca68b25fa0b1a3c07d86a76fb067c262388b3989923008c6ff2a570f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b96082f312de6a9d0195ac49836bc420e1dc898eb893e37217cb2ef854af8e57f4de9e1ee8a2017b377d2f29d3688f5d055a3f7bad99381498b786a5c62b678"} build_url:https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011384 build_url: 'https://queue.taskcluster.net/v1/task/Zf6q8j81RjiJ2MgQffZ93A/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/9ed158d58c20794bb0e05d1019a77b4535bf292f381b63fa1f2df102e6aa76f0f5d473d5ca68b25fa0b1a3c07d86a76fb067c262388b3989923008c6ff2a570f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b96082f312de6a9d0195ac49836bc420e1dc898eb893e37217cb2ef854af8e57f4de9e1ee8a2017b377d2f29d3688f5d055a3f7bad99381498b786a5c62b678"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:37.358064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:37.358420) ========= 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=a0d2d2de893abaa8702a9954000001a7-1453554799.309831-1978294676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 05:51:37.441662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 05:51:37.442046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 05:51:37.442389) ========= ========= Total master_lag: 0.33 =========