builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1452000631.14 results: success (0) buildid: 20160105030211 builduid: 7e02c8805cdc48889fc37f38bdfe04e4 revision: 29258f59e5456a1a518ccce6b473b50c1173477e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.139825) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.140279) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.140589) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006297 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.179186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.179480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.198682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.198989) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017606 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.249797) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.250098) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.250496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.251151) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 05:30:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-01-05 05:30:31 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.429329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.429641) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.080630 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.522096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:31.522517) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29258f59e5456a1a518ccce6b473b50c1173477e --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 29258f59e5456a1a518ccce6b473b50c1173477e --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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 05:30:31,709 truncating revision to first 12 chars 2016-01-05 05:30:31,709 Setting DEBUG logging. 2016-01-05 05:30:31,709 attempt 1/10 2016-01-05 05:30:31,709 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29258f59e545?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 05:30:31,957 unpacking tar archive at: mozilla-central-29258f59e545/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:32.053433) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:32.053768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:32.064497) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:32.064982) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 05:30:32.065476) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-05 05:30:32.065808) ========= /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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:32 INFO - MultiFileLogger online at 20160105 05:30:32 in /builds/slave/test-pgo 05:30:32 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:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:30:32 INFO - {'append_to_log': False, 05:30:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:30:32 INFO - 'blob_upload_branch': 'Firefox', 05:30:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:30:32 INFO - 'branch': 'Firefox', 05:30:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:32 INFO - 'config_files': ('talos/linux_config.py',), 05:30:32 INFO - 'default_actions': ('clobber', 05:30:32 INFO - 'read-buildbot-config', 05:30:32 INFO - 'download-and-extract', 05:30:32 INFO - 'populate-webroot', 05:30:32 INFO - 'create-virtualenv', 05:30:32 INFO - 'install', 05:30:32 INFO - 'run-tests'), 05:30:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:32 INFO - 'download_minidump_stackwalk': True, 05:30:32 INFO - 'download_symbols': 'ondemand', 05:30:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:32 INFO - 'installer_path': 'installer.exe', 05:30:32 INFO - 'log_level': 'info', 05:30:32 INFO - 'log_name': 'talos', 05:30:32 INFO - 'log_to_console': True, 05:30:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:32 INFO - 'opt_config_files': (), 05:30:32 INFO - 'pip_index': False, 05:30:32 INFO - 'sps_profile': False, 05:30:32 INFO - 'sps_profile_interval': 0, 05:30:32 INFO - 'suite': 'dromaeojs', 05:30:32 INFO - 'system_bits': '32', 05:30:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:32 INFO - 'title': 'talos-linux64-ix-004', 05:30:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:32 INFO - 'use_talos_json': True, 05:30:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:30:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:32 INFO - 'work_dir': 'build'} 05:30:32 INFO - ##### 05:30:32 INFO - ##### Running clobber step. 05:30:32 INFO - ##### 05:30:32 INFO - Running pre-action listener: _resource_record_pre_action 05:30:32 INFO - Running main action method: clobber 05:30:32 INFO - rmtree: /builds/slave/test-pgo/build 05:30:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:30:37 INFO - Running post-action listener: _resource_record_post_action 05:30:37 INFO - ##### 05:30:37 INFO - ##### Running read-buildbot-config step. 05:30:37 INFO - ##### 05:30:37 INFO - Running pre-action listener: _resource_record_pre_action 05:30:37 INFO - Running main action method: read_buildbot_config 05:30:37 INFO - Using buildbot properties: 05:30:37 INFO - { 05:30:37 INFO - "project": "", 05:30:37 INFO - "product": "firefox", 05:30:37 INFO - "script_repo_revision": "production", 05:30:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:30:37 INFO - "repository": "", 05:30:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:30:37 INFO - "buildid": "20160105030211", 05:30:37 INFO - "stage_platform": "linux64-pgo", 05:30:37 INFO - "basedir": "/builds/slave/test-pgo", 05:30:37 INFO - "nightly_build": "True", 05:30:37 INFO - "buildnumber": 293, 05:30:37 INFO - "slavename": "talos-linux64-ix-004", 05:30:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:30:37 INFO - "platform": "ubuntu64_hw", 05:30:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:30:37 INFO - "branch": "mozilla-central", 05:30:37 INFO - "repo_path": "mozilla-central", 05:30:37 INFO - "revision": "29258f59e5456a1a518ccce6b473b50c1173477e", 05:30:37 INFO - "pgo_build": "True", 05:30:37 INFO - "builduid": "7e02c8805cdc48889fc37f38bdfe04e4", 05:30:37 INFO - "slavebuilddir": "test" 05:30:37 INFO - } 05:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:30:37 INFO - Running post-action listener: _resource_record_post_action 05:30:37 INFO - ##### 05:30:37 INFO - ##### Running download-and-extract step. 05:30:37 INFO - ##### 05:30:37 INFO - Running pre-action listener: _resource_record_pre_action 05:30:37 INFO - Running main action method: download_and_extract 05:30:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 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/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/test_packages.json 05:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/test_packages.json 05:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:30:43 INFO - Downloaded 1302 bytes. 05:30:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:30:43 INFO - Using the following test package requirements: 05:30:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'jsshell-linux-x86_64.zip'], 05:30:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:30:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:30:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:30:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:30:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:43 INFO - https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:51 INFO - Downloaded 24052344 bytes. 05:30:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:30:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:30:52 INFO - Return code: 0 05:30:52 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: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 - https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:54 INFO - Downloaded 24052344 bytes. 05:30:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:30:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:30:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:30:55 INFO - Return code: 0 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 - https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:56 INFO - Downloaded 11132285 bytes. 05:30:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:30:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:30:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:30:56 INFO - Return code: 0 05:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:56 INFO - https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNicrLuETJqAvwd-oZeFQA/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:58 INFO - Downloaded 54987086 bytes. 05:30:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:58 INFO - mkdir: /builds/slave/test-pgo/properties 05:30:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:30:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:30:58 INFO - Contents: 05:30:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:30:58 INFO - Running post-action listener: _resource_record_post_action 05:30:58 INFO - Running post-action listener: set_extra_try_arguments 05:30:58 INFO - ##### 05:30:58 INFO - ##### Running populate-webroot step. 05:30:58 INFO - ##### 05:30:58 INFO - Running pre-action listener: _resource_record_pre_action 05:30:58 INFO - Running main action method: populate_webroot 05:30:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:58 INFO - '--tppagecycles', 05:30:58 INFO - '7'], 05:30:58 INFO - 'tests': ['tsvgm']}}, 05:30:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'tests': ['damp', 'tps']}, 05:30:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['damp', 'tps']}, 05:30:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:58 INFO - 'other': {'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'other_l64': {'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:58 INFO - 'ts_paint', 05:30:58 INFO - 'tpaint', 05:30:58 INFO - 'sessionrestore', 05:30:58 INFO - 'sessionrestore_no_auto_restore']}, 05:30:58 INFO - 'svgr': {'tests': ['tsvgx', 05:30:58 INFO - 'tsvgr_opacity', 05:30:58 INFO - 'tart', 05:30:58 INFO - 'tscrollx', 05:30:58 INFO - 'cart']}, 05:30:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['tsvgx', 05:30:58 INFO - 'tsvgr_opacity', 05:30:58 INFO - 'tart', 05:30:58 INFO - 'tscrollx', 05:30:58 INFO - 'cart']}, 05:30:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'tests': ['tp5o']}, 05:30:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'talos_options': ['--e10s'], 05:30:58 INFO - 'tests': ['tp5o']}, 05:30:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'talos_options': ['--xperf_path', 05:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:58 INFO - 'tests': ['tp5n']}, 05:30:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:58 INFO - 'talos_options': ['--e10s', 05:30:58 INFO - '--xperf_path', 05:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:58 INFO - 'tests': ['tp5n']}}, 05:30:58 INFO - 'talos.zip': {'path': '', 05:30:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:58 INFO - Running post-action listener: _resource_record_post_action 05:30:58 INFO - ##### 05:30:58 INFO - ##### Running create-virtualenv step. 05:30:58 INFO - ##### 05:30:58 INFO - Running pre-action listener: _resource_record_pre_action 05:30:58 INFO - Running main action method: create_virtualenv 05:30:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:30:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:30:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:58 INFO - Using real prefix '/usr' 05:30:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:30:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:01 INFO - Installing pip.................done. 05:31:01 INFO - Return code: 0 05:31:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:31:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:31:01 INFO - Using env: {'DISPLAY': ':0', 05:31:01 INFO - 'HOME': '/home/cltbld', 05:31:01 INFO - 'LANG': 'en_US.UTF-8', 05:31:01 INFO - 'LANGUAGE': 'en_US:en', 05:31:01 INFO - 'LOGNAME': 'cltbld', 05:31:01 INFO - 'MAIL': '/var/mail/cltbld', 05:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:01 INFO - 'MOZ_NO_REMOTE': '1', 05:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:01 INFO - 'NO_EM_RESTART': '1', 05:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:01 INFO - 'SHELL': '/bin/bash', 05:31:01 INFO - 'SHLVL': '1', 05:31:01 INFO - 'TERM': 'linux', 05:31:01 INFO - 'TMOUT': '86400', 05:31:01 INFO - 'USER': 'cltbld', 05:31:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:01 INFO - '_': '/tools/buildbot/bin/python'} 05:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:01 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:31:01 INFO - Cleaning up... 05:31:01 INFO - Return code: 0 05:31:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:31:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:31:01 INFO - Using env: {'DISPLAY': ':0', 05:31:01 INFO - 'HOME': '/home/cltbld', 05:31:01 INFO - 'LANG': 'en_US.UTF-8', 05:31:01 INFO - 'LANGUAGE': 'en_US:en', 05:31:01 INFO - 'LOGNAME': 'cltbld', 05:31:01 INFO - 'MAIL': '/var/mail/cltbld', 05:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:01 INFO - 'MOZ_NO_REMOTE': '1', 05:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:01 INFO - 'NO_EM_RESTART': '1', 05:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:01 INFO - 'SHELL': '/bin/bash', 05:31:01 INFO - 'SHLVL': '1', 05:31:01 INFO - 'TERM': 'linux', 05:31:01 INFO - 'TMOUT': '86400', 05:31:01 INFO - 'USER': 'cltbld', 05:31:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:01 INFO - '_': '/tools/buildbot/bin/python'} 05:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:01 INFO - Downloading/unpacking psutil>=0.7.1 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:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:31:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:31:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:03 INFO - Installing collected packages: psutil 05:31:03 INFO - Running setup.py install for psutil 05:31:03 INFO - building 'psutil._psutil_linux' extension 05:31:03 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:31:03 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:31:03 INFO - building 'psutil._psutil_posix' extension 05:31:03 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:31:03 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:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:04 INFO - Successfully installed psutil 05:31:04 INFO - Cleaning up... 05:31:04 INFO - Return code: 0 05:31:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:31:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:31:04 INFO - Using env: {'DISPLAY': ':0', 05:31:04 INFO - 'HOME': '/home/cltbld', 05:31:04 INFO - 'LANG': 'en_US.UTF-8', 05:31:04 INFO - 'LANGUAGE': 'en_US:en', 05:31:04 INFO - 'LOGNAME': 'cltbld', 05:31:04 INFO - 'MAIL': '/var/mail/cltbld', 05:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:04 INFO - 'MOZ_NO_REMOTE': '1', 05:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:04 INFO - 'NO_EM_RESTART': '1', 05:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:04 INFO - 'SHELL': '/bin/bash', 05:31:04 INFO - 'SHLVL': '1', 05:31:04 INFO - 'TERM': 'linux', 05:31:04 INFO - 'TMOUT': '86400', 05:31:04 INFO - 'USER': 'cltbld', 05:31:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:04 INFO - '_': '/tools/buildbot/bin/python'} 05:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:31:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:31:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:06 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:31:06 INFO - Installing collected packages: mozsystemmonitor 05:31:06 INFO - Running setup.py install for mozsystemmonitor 05:31:06 INFO - Successfully installed mozsystemmonitor 05:31:06 INFO - Cleaning up... 05:31:06 INFO - Return code: 0 05:31:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:06 INFO - Using env: {'DISPLAY': ':0', 05:31:06 INFO - 'HOME': '/home/cltbld', 05:31:06 INFO - 'LANG': 'en_US.UTF-8', 05:31:06 INFO - 'LANGUAGE': 'en_US:en', 05:31:06 INFO - 'LOGNAME': 'cltbld', 05:31:06 INFO - 'MAIL': '/var/mail/cltbld', 05:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:06 INFO - 'MOZ_NO_REMOTE': '1', 05:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:06 INFO - 'NO_EM_RESTART': '1', 05:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:06 INFO - 'SHELL': '/bin/bash', 05:31:06 INFO - 'SHLVL': '1', 05:31:06 INFO - 'TERM': 'linux', 05:31:06 INFO - 'TMOUT': '86400', 05:31:06 INFO - 'USER': 'cltbld', 05:31:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:06 INFO - '_': '/tools/buildbot/bin/python'} 05:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:06 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:06 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:06 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:06 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:06 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:06 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:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:31:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:31:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:31:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:08 INFO - Downloading docopt-0.6.1.tar.gz 05:31:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:31:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:08 INFO - Running setup.py install for blobuploader 05:31:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:31:08 INFO - Running setup.py install for requests 05:31:09 INFO - Running setup.py install for docopt 05:31:09 INFO - Successfully installed blobuploader requests docopt 05:31:09 INFO - Cleaning up... 05:31:09 INFO - Return code: 0 05:31:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:31:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:09 INFO - Using env: {'DISPLAY': ':0', 05:31:09 INFO - 'HOME': '/home/cltbld', 05:31:09 INFO - 'LANG': 'en_US.UTF-8', 05:31:09 INFO - 'LANGUAGE': 'en_US:en', 05:31:09 INFO - 'LOGNAME': 'cltbld', 05:31:09 INFO - 'MAIL': '/var/mail/cltbld', 05:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:09 INFO - 'MOZ_NO_REMOTE': '1', 05:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:09 INFO - 'NO_EM_RESTART': '1', 05:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:09 INFO - 'SHELL': '/bin/bash', 05:31:09 INFO - 'SHLVL': '1', 05:31:09 INFO - 'TERM': 'linux', 05:31:09 INFO - 'TMOUT': '86400', 05:31:09 INFO - 'USER': 'cltbld', 05:31:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:09 INFO - '_': '/tools/buildbot/bin/python'} 05:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:09 INFO - Running setup.py (path:/tmp/pip-UxIoow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:09 INFO - Running setup.py (path:/tmp/pip-Ypb0ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:09 INFO - Running setup.py (path:/tmp/pip-LW2yHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:09 INFO - Running setup.py (path:/tmp/pip-qAeuN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:09 INFO - Running setup.py (path:/tmp/pip-z0ksx_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:10 INFO - Running setup.py (path:/tmp/pip-jRyg6s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:10 INFO - Running setup.py (path:/tmp/pip-M17GgX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:10 INFO - Running setup.py (path:/tmp/pip-emO5CN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:10 INFO - Running setup.py (path:/tmp/pip-nFPpBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:10 INFO - Running setup.py (path:/tmp/pip-GDekJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:10 INFO - Running setup.py (path:/tmp/pip-FjwSUl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:10 INFO - Running setup.py (path:/tmp/pip-p8j0E4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:10 INFO - Running setup.py (path:/tmp/pip-x_yure-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:10 INFO - Running setup.py (path:/tmp/pip-KrGBrx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:10 INFO - Running setup.py (path:/tmp/pip-iTdCEw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:10 INFO - Running setup.py (path:/tmp/pip-mkBkDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:10 INFO - Running setup.py (path:/tmp/pip-ruGCUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:10 INFO - Running setup.py install for manifestparser 05:31:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for mozcrash 05:31:11 INFO - Running setup.py install for mozdebug 05:31:11 INFO - Running setup.py install for mozdevice 05:31:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for mozfile 05:31:11 INFO - Running setup.py install for mozhttpd 05:31:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for mozinfo 05:31:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for mozInstall 05:31:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for mozleak 05:31:11 INFO - Running setup.py install for mozlog 05:31:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:31:11 INFO - Running setup.py install for moznetwork 05:31:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Running setup.py install for mozprocess 05:31:12 INFO - Running setup.py install for mozprofile 05:31:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Running setup.py install for mozrunner 05:31:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Running setup.py install for mozscreenshot 05:31:12 INFO - Running setup.py install for moztest 05:31:12 INFO - Running setup.py install for mozversion 05:31:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:31:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:12 INFO - Cleaning up... 05:31:12 INFO - Return code: 0 05:31:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:31:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:12 INFO - Using env: {'DISPLAY': ':0', 05:31:12 INFO - 'HOME': '/home/cltbld', 05:31:12 INFO - 'LANG': 'en_US.UTF-8', 05:31:12 INFO - 'LANGUAGE': 'en_US:en', 05:31:12 INFO - 'LOGNAME': 'cltbld', 05:31:12 INFO - 'MAIL': '/var/mail/cltbld', 05:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:12 INFO - 'MOZ_NO_REMOTE': '1', 05:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:12 INFO - 'NO_EM_RESTART': '1', 05:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:12 INFO - 'SHELL': '/bin/bash', 05:31:12 INFO - 'SHLVL': '1', 05:31:12 INFO - 'TERM': 'linux', 05:31:12 INFO - 'TMOUT': '86400', 05:31:12 INFO - 'USER': 'cltbld', 05:31:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:12 INFO - '_': '/tools/buildbot/bin/python'} 05:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:12 INFO - Running setup.py (path:/tmp/pip-pJFen2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:13 INFO - Running setup.py (path:/tmp/pip-FewjRS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:13 INFO - Running setup.py (path:/tmp/pip-l5NvI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:13 INFO - Running setup.py (path:/tmp/pip-T1AQSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:13 INFO - Running setup.py (path:/tmp/pip-0StVWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:13 INFO - Running setup.py (path:/tmp/pip-72MoS6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:13 INFO - Running setup.py (path:/tmp/pip-ICFoHZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:13 INFO - Running setup.py (path:/tmp/pip-Mr11D_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:13 INFO - Running setup.py (path:/tmp/pip-jAmHxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:13 INFO - Running setup.py (path:/tmp/pip-qhJrJV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:13 INFO - Running setup.py (path:/tmp/pip-VLxGcT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:13 INFO - Running setup.py (path:/tmp/pip-nYe7fq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:13 INFO - Running setup.py (path:/tmp/pip-swz0vI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:13 INFO - Running setup.py (path:/tmp/pip-uHfmvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:31:13 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:31:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:13 INFO - Running setup.py (path:/tmp/pip-zkQyvR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:31:14 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:31:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:14 INFO - Running setup.py (path:/tmp/pip-Y4zLhS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:31:14 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:31:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:14 INFO - Running setup.py (path:/tmp/pip-rf9eOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:31:14 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:31:14 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:31:14 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:31:14 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:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:15 INFO - Downloading blessings-1.5.1.tar.gz 05:31:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:31:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:15 INFO - Installing collected packages: blessings 05:31:15 INFO - Running setup.py install for blessings 05:31:16 INFO - Successfully installed blessings 05:31:16 INFO - Cleaning up... 05:31:16 INFO - Return code: 0 05:31:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:31:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:16 INFO - Reading from file tmpfile_stdout 05:31:16 INFO - Current package versions: 05:31:16 INFO - argparse == 1.2.1 05:31:16 INFO - blessings == 1.5.1 05:31:16 INFO - blobuploader == 1.2.4 05:31:16 INFO - docopt == 0.6.1 05:31:16 INFO - manifestparser == 1.1 05:31:16 INFO - mozInstall == 1.12 05:31:16 INFO - mozcrash == 0.16 05:31:16 INFO - mozdebug == 0.1 05:31:16 INFO - mozdevice == 0.47 05:31:16 INFO - mozfile == 1.2 05:31:16 INFO - mozhttpd == 0.7 05:31:16 INFO - mozinfo == 0.9 05:31:16 INFO - mozleak == 0.1 05:31:16 INFO - mozlog == 3.1 05:31:16 INFO - moznetwork == 0.27 05:31:16 INFO - mozprocess == 0.22 05:31:16 INFO - mozprofile == 0.28 05:31:16 INFO - mozrunner == 6.11 05:31:16 INFO - mozscreenshot == 0.1 05:31:16 INFO - mozsystemmonitor == 0.0 05:31:16 INFO - moztest == 0.7 05:31:16 INFO - mozversion == 1.4 05:31:16 INFO - psutil == 3.1.1 05:31:16 INFO - requests == 1.2.3 05:31:16 INFO - wsgiref == 0.1.2 05:31:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:31:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:16 INFO - Using env: {'DISPLAY': ':0', 05:31:16 INFO - 'HOME': '/home/cltbld', 05:31:16 INFO - 'LANG': 'en_US.UTF-8', 05:31:16 INFO - 'LANGUAGE': 'en_US:en', 05:31:16 INFO - 'LOGNAME': 'cltbld', 05:31:16 INFO - 'MAIL': '/var/mail/cltbld', 05:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:16 INFO - 'MOZ_NO_REMOTE': '1', 05:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:16 INFO - 'NO_EM_RESTART': '1', 05:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:16 INFO - 'SHELL': '/bin/bash', 05:31:16 INFO - 'SHLVL': '1', 05:31:16 INFO - 'TERM': 'linux', 05:31:16 INFO - 'TMOUT': '86400', 05:31:16 INFO - 'USER': 'cltbld', 05:31:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:16 INFO - '_': '/tools/buildbot/bin/python'} 05:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 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:31:16 INFO - Cleaning up... 05:31:16 INFO - Return code: 0 05:31:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:31:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:31:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:16 INFO - Using env: {'DISPLAY': ':0', 05:31:16 INFO - 'HOME': '/home/cltbld', 05:31:16 INFO - 'LANG': 'en_US.UTF-8', 05:31:16 INFO - 'LANGUAGE': 'en_US:en', 05:31:16 INFO - 'LOGNAME': 'cltbld', 05:31:16 INFO - 'MAIL': '/var/mail/cltbld', 05:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:16 INFO - 'MOZ_NO_REMOTE': '1', 05:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:16 INFO - 'NO_EM_RESTART': '1', 05:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:16 INFO - 'SHELL': '/bin/bash', 05:31:16 INFO - 'SHLVL': '1', 05:31:16 INFO - 'TERM': 'linux', 05:31:16 INFO - 'TMOUT': '86400', 05:31:16 INFO - 'USER': 'cltbld', 05:31:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:16 INFO - '_': '/tools/buildbot/bin/python'} 05:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:16 INFO - Downloading/unpacking jsonschema 05:31:16 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:16 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:16 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:16 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:16 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:16 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:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:31:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:31:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:18 INFO - warning: no files found matching '*.txt' 05:31:18 INFO - no previously-included directories found matching 'build' 05:31:18 INFO - no previously-included directories found matching 'dist' 05:31:18 INFO - no previously-included directories found matching '.git*' 05:31:18 INFO - Installing collected packages: jsonschema, functools32 05:31:18 INFO - Running setup.py install for functools32 05:31:18 INFO - warning: no files found matching '*.txt' 05:31:18 INFO - no previously-included directories found matching 'build' 05:31:18 INFO - no previously-included directories found matching 'dist' 05:31:18 INFO - no previously-included directories found matching '.git*' 05:31:18 INFO - Successfully installed jsonschema functools32 05:31:18 INFO - Cleaning up... 05:31:18 INFO - Return code: 0 05:31:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:31: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:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31: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:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7be576cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, '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': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', '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:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:31:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:31:18 INFO - Using env: {'DISPLAY': ':0', 05:31:18 INFO - 'HOME': '/home/cltbld', 05:31:18 INFO - 'LANG': 'en_US.UTF-8', 05:31:18 INFO - 'LANGUAGE': 'en_US:en', 05:31:18 INFO - 'LOGNAME': 'cltbld', 05:31:18 INFO - 'MAIL': '/var/mail/cltbld', 05:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:18 INFO - 'MOZ_NO_REMOTE': '1', 05:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:18 INFO - 'NO_EM_RESTART': '1', 05:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:18 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:18 INFO - 'SHELL': '/bin/bash', 05:31:18 INFO - 'SHLVL': '1', 05:31:18 INFO - 'TERM': 'linux', 05:31:18 INFO - 'TMOUT': '86400', 05:31:18 INFO - 'USER': 'cltbld', 05:31:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:18 INFO - '_': '/tools/buildbot/bin/python'} 05:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:19 INFO - Downloading/unpacking flake8 05:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:31:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:20 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:20 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:20 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:20 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:20 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:20 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:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:31:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:20 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:20 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:20 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:20 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:20 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:20 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:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:31:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:31:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:21 INFO - no previously-included directories found matching 'docs/_build' 05:31:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:21 INFO - Running setup.py install for pep8 05:31:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:21 INFO - no previously-included directories found matching 'docs/_build' 05:31:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:31:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:21 INFO - Cleaning up... 05:31:21 INFO - Return code: 0 05:31:21 INFO - Running post-action listener: _resource_record_post_action 05:31:21 INFO - Running post-action listener: _start_resource_monitoring 05:31:21 INFO - Starting resource monitoring. 05:31:21 INFO - ##### 05:31:21 INFO - ##### Running install 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: install 05:31:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:21 INFO - Reading from file tmpfile_stdout 05:31:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:31:21 INFO - Reading from file tmpfile_stdout 05:31:21 INFO - Output received: 05:31:21 INFO - Usage: mozinstall [options] installer 05:31:21 INFO - Options: 05:31:21 INFO - -h, --help show this help message and exit 05:31:21 INFO - -d DEST, --destination=DEST 05:31:21 INFO - Directory to install application into. [default: 05:31:21 INFO - "/builds/slave/test-pgo"] 05:31:21 INFO - --app=APP Application being installed. [default: firefox] 05:31:21 INFO - mkdir: /builds/slave/test-pgo/build/application 05:31:21 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:21 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:37 INFO - Reading from file tmpfile_stdout 05:31:37 INFO - Output received: 05:31:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:31:37 INFO - Running post-action listener: _resource_record_post_action 05:31:37 INFO - ##### 05:31:37 INFO - ##### Running run-tests step. 05:31:37 INFO - ##### 05:31:37 INFO - Running pre-action listener: _resource_record_pre_action 05:31:37 INFO - Running main action method: run_tests 05:31:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:31:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:31:37 INFO - Python 2.7.3 05:31:37 INFO - Return code: 0 05:31:37 INFO - grabbing minidump binary from tooltool 05:31: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:31:37 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 0x2c5b840>, '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 0x2bc86b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:31:37 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:37 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:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:37 INFO - Return code: 0 05:31:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:31:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:31:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:31:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:31:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:31:38 INFO - Return code: 0 05:31:38 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/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:38 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/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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:38 INFO - Using env: {'DISPLAY': ':0', 05:31:38 INFO - 'HOME': '/home/cltbld', 05:31:38 INFO - 'LANG': 'en_US.UTF-8', 05:31:38 INFO - 'LANGUAGE': 'en_US:en', 05:31:38 INFO - 'LOGNAME': 'cltbld', 05:31:38 INFO - 'MAIL': '/var/mail/cltbld', 05:31:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:38 INFO - 'MOZ_NO_REMOTE': '1', 05:31:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:38 INFO - 'NO_EM_RESTART': '1', 05:31:38 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:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:31:38 INFO - 'SHELL': '/bin/bash', 05:31:38 INFO - 'SHLVL': '1', 05:31:38 INFO - 'TERM': 'linux', 05:31:38 INFO - 'TMOUT': '86400', 05:31:38 INFO - 'USER': 'cltbld', 05:31:38 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541', 05:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:38 INFO - '_': '/tools/buildbot/bin/python'} 05:31:38 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/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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:39 INFO - mozversion application_buildid: 20160105030211 05:31:39 INFO - mozversion application_changeset: 29258f59e5456a1a518ccce6b473b50c1173477e 05:31:39 INFO - mozversion application_display_name: Nightly 05:31:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:39 INFO - mozversion application_name: Firefox 05:31:39 INFO - mozversion application_remotingname: firefox 05:31:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:39 INFO - mozversion application_vendor: Mozilla 05:31:39 INFO - mozversion application_version: 46.0a1 05:31:39 INFO - mozversion platform_buildid: 20160105030211 05:31:39 INFO - mozversion platform_changeset: 29258f59e5456a1a518ccce6b473b50c1173477e 05:31:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:39 INFO - mozversion platform_version: 46.0a1 05:31:39 INFO - using testdate: 1452000699 05:31:39 INFO - actual date: 1452000699 05:31:39 INFO - starting webserver on 'localhost:48105' 05:31:39 INFO - SUITE-START | Running 3 tests 05:31:39 INFO - TEST-START | dromaeo_css 05:31:39 INFO - operating with platform_type : linux_ 05:31:39 INFO - Initialising browser for dromaeo_css test... 05:31:39 INFO - TEST-INFO | started process 14849 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS5Xta6/profile http://localhost:48105/getInfo.html) 05:31:43 INFO - PROCESS | 14849 | __metrics Screen width/height:1600/1200 05:31:43 INFO - PROCESS | 14849 | colorDepth:24 05:31:43 INFO - PROCESS | 14849 | Browser inner width/height: 1024/697 05:31:43 INFO - PROCESS | 14849 | __metrics 05:31:43 INFO - PROCESS | 14849 | 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:43 INFO - PROCESS | 14849 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:45 INFO - TEST-INFO | 14849: exit 0 05:31:45 INFO - Browser initialized. 05:31:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:45 INFO - TEST-INFO | started process 14944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS5Xta6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:56 INFO - PROCESS | 14944 | RSS: Main: 150339584 05:31:56 INFO - PROCESS | 14944 | 05:32:48 INFO - PROCESS | 14944 | 1452000768195 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:57 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48105/tests/dromaeo/cssquery-ext.html) 05:34:58 INFO - PROCESS | 14944 | RSS: Main: 268132352 05:34:58 INFO - PROCESS | 14944 | 05:38:00 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-ext.html (next: http://localhost:48105/tests/dromaeo/cssquery-jquery.html) 05:38:01 INFO - PROCESS | 14944 | RSS: Main: 240922624 05:38:01 INFO - PROCESS | 14944 | 05:41:03 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48105/tests/dromaeo/cssquery-mootools.html) 05:41:03 INFO - PROCESS | 14944 | RSS: Main: 232865792 05:41:03 INFO - PROCESS | 14944 | 05:44:05 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48105/tests/dromaeo/cssquery-prototype.html) 05:44:06 INFO - PROCESS | 14944 | RSS: Main: 211738624 05:44:06 INFO - PROCESS | 14944 | 05:47:08 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48105/tests/dromaeo/cssquery-yui.html) 05:47:09 INFO - PROCESS | 14944 | RSS: Main: 219602944 05:47:09 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | Cycle 1(1): loaded http://localhost:48105/tests/dromaeo/cssquery-yui.html (next: http://localhost:48105/tests/dromaeo/cssquery-dojo.html) 05:50:12 INFO - PROCESS | 14944 | RSS: Main: 301133824 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | __start_tp_report 05:50:12 INFO - PROCESS | 14944 | _x_x_mozilla_page_load 05:50:12 INFO - PROCESS | 14944 | _x_x_mozilla_page_load_details 05:50:12 INFO - PROCESS | 14944 | |i|pagename|runs| 05:50:12 INFO - PROCESS | 14944 | |0;dojo.html;3059.3269480714243;3091.7217450429457;3131.1702398864304;3133.576967109441;3166.9366612667745;5061.54446099851;5133.7946482140715;5150.484951504857;5166.354205724279;5199.896002079956;5117.2068329409;5120.975804839038;5204.193350030741;5281.841544753664;5304.734763261831;4637.513061128592;4729.1251118543005;4741.90516189676;4804.183288840888;4899.216125419934;4739;4816.686915350491;4862.416510018803;4869.853904382874;4898.828541001066;4652.581267685924;4746.620270378361;4823.999999999983;4860.222364421711;4880.8047678092835;4726.1020406122725;4728.503507131771;4736.029114031615;4741.31250968611;4744.525547445262;4709.340692303081;4709.62323014158;4710.8351207707565;4714.962708204224;4720.457147428056;5001.17480615698;5024.321716568253;5154.407243167008;5157.742112894378;5187.118189907687;5573.498385145316;5576.693281869536;5582.134769110794;5584.581156413245;5587.078132108198;5407.324084489439;5553.722313884289;5602.327720673546;5609.915851262234;5620.325560932673;5204.973975130138;5226.320578324831;5238.030964271622;5323.387810401815;5356.866078348073;5704.201411802351;5755.654660720286;5785.595008349459;5795.1017592273265;5810.6513609183585;5519.475649813261;5520.779168833202;5523.861903452365;5524.917126243109;5525.0883604204855;5458.426865179178;5567;5579.023670857665;5579.9163012554845;5650.74571644277;5594.580406469531;5620.241267428926;5634.3802181759975;5638.520725738276;5642.605017648807;5577.888442231133;5586.91619625706;5592.440755924456;5595.18869763882;5602.803901863415;4235.512916014636;4334.371516130143;4350.0647360817575;4356.629686476685;4396.824127034883;3808.1622043150464;3848.499695039683;3903.375459926398;3933.586973367755;3949.92100158001;5231.346081739783;5261.053010458154;5266.236395722675;5272.340957380327;5274.736263186825;5472.945270547323;5593.804216852391;5628.887422251532;5630.23991761107;5630.775201898865;5214.165733482625;5258.500442458037;5264.078786212397;5279.44565820591;5325.813596524103;4474.977625111854;4797.664163508591;4798.8560343189065;4809.110314591811;4842.612590992712;5614.382417934024;5741.540676745851;5749.540036797046;5807.651540907559;5808.128780682847;5587.245721827664;5673.120666296731;5678.886422271614;5689.374168841507;5725.7137143141845;5842.883142337045;5848.298204215522;5848.707564621837;5850.736716847837;5857.062869940789;5413.269208656781;5491.039068163135;5531.502164805187;5537.390887002507;5555.055640541037;5634.380218176079;5690.573207009574;5697.658140511582;5699.829005129853;5745.971270143623;5269.71016594091;5489.258950041693;5494.203340515683;5499.477549632778;5501.889962200654;5159.09715799741;5239.266502689703;5434.0490414176575;5464.28964234647;5510.1459273812625;5448.264484294569;5452.291202143696;5455.618106732491;5459.5632349412745;5474.644148130359;5512.614117011771;5514.145307477347;5515;5548.889022219452;5551.306086739158;5267.841964741064;5323.334583177103;5371.248025276386;5379.273798037215;5421.566274698093 05:50:12 INFO - PROCESS | 14944 | |1;ext.html;529.7060131626948;537.373959337372;555.9416261292562;559.6502186133667;573.8393249890032;27696.30759231018;28434.71565284349;28443.14670559884;35052.82473587628;35900.82049589755;39553.802230988804;39849.40225896614;39864.40203396944;39983.60016399835;40062.39906401406;8326.791830204233;8487.702930397438;8545.444546104483;8600.8709869352;8602.741917742447;7536.5854877981965;7687.346575541058;9927.106560409562;10097.091261786438;10118;9769.755756106084;9846.606135754597;9850.655227067055;9853.261005424622;9861.260405469582;7565.962170189169;7729.613519324012;9911.504424778732;10001.49992500372;10030.197584193284;9986.251031172691;10150.187984961185;10203.4388108654;10208.89791102087;10211.438370889598;36129.45805812915;36590.8170459146;36619.08452288714;36619.4507082394;36659.266814663555;3271.1985563536846;3302.1414432247548;3337.5828021497314;3670.5778835433734;4114.567970363129;28161.577576336167;28410.71589284122;30398.848005759828;30863;31549.684503154906;3782.8108594570162;3829.5021647185686;3842.020284827379;3900.278448487039;3983.98008009961;252342;258048;259596;259748;261742.9999999981;60292.397076029556;60996.99999999911;61021.694891526146;61072.69463652653;61158.38841611616;63806;65478.345216547226;67309.66345168243;68439;68636.6568167156;14657.267136643126;14790.63023424423;14801.407943682347;14806.851931480764;14867.256637168099;10637.042666159929;10657.253992220625;10668.199885008655;10685.091767199876;10714.571417143226;20548;20666;20670.79329206719;20695;20709.482262943548;8291.295239904555;8535.445196062235;8538.87191692125;8686.218240358397;8712.259093968883;925.287528602972;974.4299584742863;1034.8602938603342;1063.8297872340388;1065.7974984753027;28768.568471472943;29018.12945611635;29040.41919161605;29113;30390;995.1789773436943;1024.9180065594735;1058.4813441413653;1092.6831218946415;1094.715374002749;14261.572152835432;14501.782473262909;14684.706305873822;16209.432669856498;16470.42353517621;368717;379063;379603;379749;380051;55152;55196.17205741917;55596;55792;56050.43949560534;1310.5675127207999;1313.481174935895;1325.8342707161605;1330.255057167989;1362.9795553066513;27706;28810;29488;29705.405891881608;30265;45417.54582454133;46049.934507203514;46063;46078.30882536698;46100.30849537192;227906;228938;229032;229243;229760;28204.576931345637;28654.283642909093;31996.880109196067;32419.513707294882;32482.187945301557;40768;40961.590384095776;41217.1756564873;41532.58467415287;41954.580454195064;34169.65830341665;34583.632892877904;34930.65069349376;34971.65028349684;35206.82396588001;32268.515972260906;34969;35176;37174.442383363734;37728.245435091696;32738.50892236666;33385.499217512246;33979.15052123717;33982.150446239044;33997.32005359929;30158.84920575383;31296.53363387536;32881.835590821895;33675.49486757652;33680.66319336775;24880.875595621907;24927.875360623082;25062.49875002526;25169;25456.23631291064 05:50:12 INFO - PROCESS | 14944 | |2;jquery.html;344.340587774412;345.481777333999;346.7053004945795;349.7499288009073;350.6405933917734;13584.864151358483;14086.225257610828;16472.258748356322;16593.5065844074;17360.39238626648;16026;16370.263338149782;16838;17142.314307427718;17193.226304816282;5197.272381866533;5294.258803767476;5295.232191332255;5299.947000529984;5302.416734159239;4033.495813023372;4135.565765594614;5334.813281535147;5814.069748840187;6013.75944962201;5890.116482527612;5919;5922.289325280973;5948.1375200595885;5970.731317090741;5751.137329400582;5860.413958604148;5861.648301101947;5869.735861886204;5873.2658417697785;5127.692338459704;5135.537801597837;5140.974295128501;5166.250893620404;5174.197999310113;18308.359207427675;19001.809981900144;19031.524211894673;19988.80011199884;20033.29883454072;2034.511717187879;2102.621528124937;2261.185973049701;2275.0444813178337;2407.3981504623844;9252.074792520762;9638.614455421775;12551.811722824164;12886.355682215946;12981.286029268387;1682.5709444091679;1749.2915369275463;1757.745126956597;1767.2842498788011;1819.2086442397467;60455.69772151155;64653.03020454697;64680.35319646837;64791.352086479004;64823;10195.796084078425;10204.132648724793;10222.233332500093;10232.53953572091;10240.692779216635;13306.866931330564;13454.058215924988;13470.259135747629;13476;13487.25820079905;6976.267491913378;7105.71577136919;7123.25205853378;7158.785236442915;7195;6717;6729.966350168218;6764.2221144569;6778.966105169443;6786.287439818847;4282.785860706952;4349.913001740011;4361.629261512743;4366.759828209479;4402.5597440255715;1693.2041940288045;1728.2050256881976;1774.7160454327245;1817.4275103342404;1827.4974382045043;410.1468944595235;414.1427245601576;420.1932290003201;451.7515366548385;839.8446287436843;10502.737431564272;10680.145588352912;10988.780224395467;12797.680057998437;16179.514614561582;939.4504215034145;951.900050494702;960.644561512245;1012.1396812709138;1030.1449796668746;9794.65718699842;9955.900440995641;9984.400935943866;10074.496275186211;10081.49592520371;525822;534254;538577;582358;582525;72957;78310.60844695853;80492.5975370131;80815;82141;1091.9945400272948;1113.3375641493299;1121.2823792772633;1138.834868944015;1162.2155045344527;15193.164375959428;15350.07899526032;15458.29958704519;15470.613234669223;15717.921410392875;34790.82604586961;34881.12797180091;35367.29265414626;35733.64266357303;36041.459378109874;46219.3067103987;47960.7601961988;48659.5134048655;49467.25799113088;51091.489085108675;9550.808983820145;9596.520173991134;9722;9757.853632195382;9766.414015159113;14742.557723268319;17605.207765650834;17682.64634707273;18219.817801821813;18258.36095736643;14330.713385732435;14402.567922962327;14473.21992117802;14831.703365932837;14922.179280139697;13888.305584720925;14155.858441415454;14465.710685786436;14702.485413010494;14902.478413255483;11650.825237621273;13469.12450690702;13834.446622135001;13857.861421385656;13925.860741392456;9040.231580315747;9133.949595796303;9206.677766278148;9264.583093760662;9295.488748118918;13070;13087.476500939856;13340.19958802475;13368.465261389436;14429.278536073365 05:50:12 INFO - PROCESS | 14944 | |3;mootools.html;1243.359669770069;1412.710394369154;1423.6440889777555;1504.7667611520212;1761.832625900539;6012.7594896204155;6634.303398143192;6720.596764194146;6733.39399454049;6739.46084313255;6407.423331900128;6546;6546.18172728409;6550.181227346582;6552.705128269227;1871.9251229950853;1907.8759880607786;1908.3893154190664;2096.800803923629;2132.445564153316;1889.763779527559;2100.401385605103;2140.67889816528;2147.903344349508;2151.87088774674;2105.3683894831565;2113.0280071167203;2121.86207896487;2134.3276867786676;2135.1779564867484;2104.547522282709;2114.38682781993;2136.604728125302;2139.935801925945;2142.1645558232303;2157.8057974782346;2174.3259589527297;2189.4745261137373;2190.0582749417745;2191.1016483241956;6766.086578311914;6772.255051944282;6840.657967101674;6857.27998560149;6867.622280774555;4220.704550681454;4289.356596510517;4296.8281268749215;4297.376880352363;4302.311630139194;2811.1707046421357;2882.423515296949;2896.435195136949;2902.259923719459;2911.694272101441;948.3645957208687;983.5623147699276;991.0584944302941;1016.8068067067234;1037.092544023979;9224.677136300264;9263.444193348421;9264.305177111677;9271.026542213038;9272.490013049279;3647.4164133738473;3687.778733276012;3710.7773533587533;3713.3687273163628;3728.2357116790995;7911.762647120596;7958.482698624571;7984.960075199703;8004.959975200087;8025.3980951428875;4195.223883581547;4207;4210.431591735077;4218.029853133797;4223.366495025771;3847.576766555677;3855.2867719471988;3884.2037382336553;3886.553046399644;3886.591907849635;3088.382323535302;3135.8275294858545;3155.4320222360197;3175;3185.792923459968;1057.0750593230923;1072.2762135558467;1076.9515371808288;1082.4641802307908;1089.5587287148717;1073.8711354637494;1076.590895459736;1111.8943700348455;1223.2782658231686;1328.1964411531078;6369.5541312108635;6373.171487706569;6452.838489071918;6475.384838440341;6476.481881449473;1081.8809930907594;1084.3060441317564;1094.5293523784849;1104.6354702948008;1114.2812885688686;5292.44429334922;5408.296921400193;5408.567314614821;5412.621116521885;5413.296271484682;7884.605769711491;8067.273945344947;8236.50580965144;8284.627191776384;8304.875426868603;8132.064812546633;8230.135835737161;8238.176182381714;8239.217274358927;8243.299319557786;6472.773452929125;6548.9017664735065;6602.042703807921;6622.8344291393105;6626.602403855784;6414.711337989895;6436.613803171825;6437.034444833313;6442.742290308335;6447;7075.398591119812;7289.817754556178;7383.630818459163;7450.0687414073245;7474.476786624884;7253.927460725326;7430.517016393917;7433.479656423999;7467.551946883204;7570.1672815989095;5733.741981610754;5792.507636850746;5802.854928626818;5807;5808.738606762621;6581.769638062645;6644.734210631714;6669.233038200475;6690.69891854858;6704.229013663296;6317.747290108344;6388.8083357499345;6400;6442.967785161044;6528.771492997722;5915.674637894785;6002.489788368038;6051.394860513913;6121.877562448815;6401.455876250571;6116.235470566179;6144.754209831557;6159.630422174684;6196.504279657526;6287.811365659038;5861.413858614104;5881.470667639933;5895.64626122434;5898.056310990221;5906.734196961061;5953.672548009901;5978.252718410199;5982.4316689914385;5988.640681559121;5997.070454079625 05:50:12 INFO - PROCESS | 14944 | |4;prototype.html;312.47972126409525;318.10136364769534;320.04466666999;327.75290021468305;333.21195372943;5741.0240259155935;5890.175375447441;5925.407459254078;5926.199963004993;5933.910991335128;5693.658380497162;5814.883702325951;5822.737976791044;5829.504492118175;5831;4569.200389931765;4572.291294849287;4573.153966516188;4575.816967321303;4580.748058856761;4339.566043395651;4435.68950173488;4435.911281774363;4473.530279320673;4565.6119229865335;4373.1909596724545;4461.152381047591;4472.508024117345;4472.82108715651;4493.2136876046725;4477.283634618478;4480.977595112036;4484.215262329096;4486.506484286726;4502.594766471017;3921.372580387153;3921.686265098785;3922.941155882664;3929.4695216146024;3929.5677475477673;5404.972975135139;5579.637323573996;5584.497395234448;5610.803621873215;5621.269234999465;5173.224016397533;5182.507661772125;5184.248283998799;5185.403678576974;5189.7405129743365;5977.3723759005115;6235.095911092912;6235.469985051276;6250.406211409909;6250.499960003189;4179.895502612429;4253.808578613939;4258.276093064186;4258.318669012943;4283.357496375537;6429.099926010363;6525.93474065258;6527.93472065278;6528.249251336109;6536.934630653727;4384.583464570861;4384.8246070157475;4385.3641222022625;4387.912241755147;4388.5830846069575;4401.22978478765;4401.22978478765;4434.512203657595;4439.045605194899;4554.24854898938;5236.031334203185;5263.052650522943;5268.28878101459;5269.78920843162;5274.208868669731;6335.208098987627;6345.175127233522;6347.39699728525;6347.492200624031;6351.4283714465;1567.5219058187363;1575.330484544087;1576.5822057154862;1577.6213708709827;1579.336678594993;1036.0313107244751;1036.3056751976194;1050.7110544600143;1061.6602687140196;1109.7447587054862;6018.21763170785;6021.969890150521;6023.728932197974;6025.517958563304;6029.487493563009;6469;6472.805815825533;6473.417392434703;6476.35236476358;6490.902636460457;6043.909341359883;6067.605605635619;6072.817815465543;6073.362296958844;6077.3314935357075;3432.6052503962364;3524.594671612746;3527.347440723423;3530.258645684435;3535.9469607955903;6833.863322733617;6836.042953986446;6837.042814006043;6838.589684618939;6850.862982740317;6650.501212409089;6650.800475985729;6651.467882569383;6652.767153149616;6654.13496245485;6602.60384376939;6789.1852977643;6797.116374871235;6817.454603631698;6826.112605361272;6257.28041275241;6402.807915762534;6503.414692677682;6509.349065093453;6510.18622672166;6345.714442850175;6480.8703825922275;6490.967545162244;6500.284968653539;6516.837079072871;6787.626680532618;6803.251642319242;6804.251532331538;6807.115075040213;6817.795466136024;4430.113977204507;4469.7318160910445;4496.437945256843;4507.4365704286965;4507.526709695435;6535.117759102651;6550.868982620416;6554.213494380514;6560.967195163994;6576.704048317742;6359.491240700825;6375.87248255023;6377.585456945284;6380.298167201511;6388.616682999035;6238.189035425366;6361.522885783492;6362.0774987627465;6366.77716279928;6367.840803979938;6244.687765611792;6256.061590761422;6258.217722784652;6258.468030217483;6261.906071409024;6354.1104245406605;6383.234011918599;6398.0083087121575;6400.407834826902;6404.039394090923;6085.482733967485;6192.690365481798;6228.159198508143;6239.282482514387;6239.78160764371 05:50:12 INFO - PROCESS | 14944 | |5;yui.html;760.5018712743154;839.6347588798873;853.1127627267642;856.820067785765;859.8649782287379;13010.674733131664;13257.7348453031;13258.469661213552;13266.734665306712;13277.933610331958;11551.364674942895;12782.10525263232;12887.355632218376;12890.548830790924;12894.5486907958;662.8740539297543;802.7872613757359;825.4634487583058;830.1573902488979;830.4933990265932;829.4194064155085;839.4375768235298;840.920112589303;841.2092632925031;841.6338892581716;721.9639018049103;736.1681300130845;868.1448772958631;877.302544477139;879.0901417033372;859.9828003439959;863.447393668053;871.1288711288711;873.9992708348968;874.45783614159;634.9301576826546;636.141209367355;637.6811594202899;639.11163482759;639.389383139101;13632.591022269347;13636.727265454734;13707.314634268347;13766.449342026408;13771.104878182887;12116.575919842851;12278.631641050693;12307.507699692002;12326.07554433412;12531.93734031333;10319.89680103197;10337.37975721459;10497.160227181883;10620.840687389695;10842.13262938971;3605.5853576838476;3663.8900832975055;3696.6488183622514;3820.8280627371555;3827.885163445101;43521.782391088156;44156.36358182377;44390.112197756185;44443;44487.33269000967;9895.802083958424;10251.12865406434;10369;10436.478176091165;10503.737406564896;17794.37719679831;17982.10089495546;18032.459026229233;18585.25658973653;18762.34331798408;7438;7639.274268944441;7661.425393095428;7781.5331080135375;8189.8771518427275;4254.808533615995;4279.358096285582;4380.649548036149;4417.779111044435;4522.796474158671;3068.5397190421168;3100.7209351158504;3102.550130231104;3106;3113.1438854314792;541.2206422751226;550.1143159513181;552.4254775034;556.0824639345113;569.0894568690063;462.8310666606664;501.34073693093467;526.5050852198921;593.8782549577327;598.853280946171;7459.776206713699;7482.901704101066;7682.231776822385;7693.4614576979075;7727.5749833758555;588.6314319207859;595.1816252652603;595.7646729541807;607.3592360060179;620.2835724737845;3729.9254014920093;3854.5759966403675;3906.5507466641134;4049.979750101231;4168.520620128724;55126.44873551213;55326.17010744842;55525.722371387885;57495;60312;49653;50130.24804627933;50213.24680129801;50276.748616256686;50414.747926260134;45342;45472.77263613661;45765.542344576796;46269.7686511572;46737;8184.508929464251;8388.245057944814;8402.243798058204;8420.242178203991;8600.655973760979;34228;34346.82826585851;35038.299234015685;35105.82447087748;35156.64843351534;40991;41838.372424414265;43866.780666097744;44225;46616.53383466258;10567.10179634709;10871.29336593119;10923.47527316117;11163.162762792985;11224.775504490028;11096.61161859331;11200.831987520356;11227.7754444909;12061.51753929868;12474.937625311815;11611.361375124112;11686.532538698357;11695.298282103102;11761.529538818351;12072.275663460221;11246.100311975186;11493.82759258595;11689.707757306136;11858.940705296418;11951.641450756144;10906.182036347147;11165.218434709492;11368.658940231806;11583.942080289882;11603.709907252049;9384.624615015597;9699.757506062122;9786.1192492676;10050.09549140581;10285.2800303978;8809.251213646912;8934.821303573763;9129.315301352557;9650.95174524123;9899.604015839286 05:50:12 INFO - PROCESS | 14944 | __end_tp_report 05:50:12 INFO - PROCESS | 14944 | __start_cc_report 05:50:12 INFO - PROCESS | 14944 | _x_x_mozilla_cycle_collect,898 05:50:12 INFO - PROCESS | 14944 | __end_cc_report 05:50:12 INFO - PROCESS | 14944 | __startTimestamp1452001812364__endTimestamp 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | ------- Summary: start ------- 05:50:12 INFO - PROCESS | 14944 | Number of tests: 6 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#0] dojo.html Cycles:165 Average:5200.05 Median:5407.32 stddev:578.90 (10.7%) stddev-sans-first:555.78 05:50:12 INFO - PROCESS | 14944 | Values: 3059.3 3091.7 3131.2 3133.6 3166.9 5061.5 5133.8 5150.5 5166.4 5199.9 5117.2 5121.0 5204.2 5281.8 5304.7 4637.5 4729.1 4741.9 4804.2 4899.2 4739.0 4816.7 4862.4 4869.9 4898.8 4652.6 4746.6 4824.0 4860.2 4880.8 4726.1 4728.5 4736.0 4741.3 4744.5 4709.3 4709.6 4710.8 4715.0 4720.5 5001.2 5024.3 5154.4 5157.7 5187.1 5573.5 5576.7 5582.1 5584.6 5587.1 5407.3 5553.7 5602.3 5609.9 5620.3 5205.0 5226.3 5238.0 5323.4 5356.9 5704.2 5755.7 5785.6 5795.1 5810.7 5519.5 5520.8 5523.9 5524.9 5525.1 5458.4 5567.0 5579.0 5579.9 5650.7 5594.6 5620.2 5634.4 5638.5 5642.6 5577.9 5586.9 5592.4 5595.2 5602.8 4235.5 4334.4 4350.1 4356.6 4396.8 3808.2 3848.5 3903.4 3933.6 3949.9 5231.3 5261.1 5266.2 5272.3 5274.7 5472.9 5593.8 5628.9 5630.2 5630.8 5214.2 5258.5 5264.1 5279.4 5325.8 4475.0 4797.7 4798.9 4809.1 4842.6 5614.4 5741.5 5749.5 5807.7 5808.1 5587.2 5673.1 5678.9 5689.4 5725.7 5842.9 5848.3 5848.7 5850.7 5857.1 5413.3 5491.0 5531.5 5537.4 5555.1 5634.4 5690.6 5697.7 5699.8 5746.0 5269.7 5489.3 5494.2 5499.5 5501.9 5159.1 5239.3 5434.0 5464.3 5510.1 5448.3 5452.3 5455.6 5459.6 5474.6 5512.6 5514.1 5515.0 5548.9 5551.3 5267.8 5323.3 5371.2 5379.3 5421.6 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#1] ext.html Cycles:180 Average:45857.66 Median:33989.74 stddev:77544.41 (228.1%) stddev-sans-first:77687.25 05:50:12 INFO - PROCESS | 14944 | Values: 529.7 537.4 555.9 559.7 573.8 27696.3 28434.7 28443.1 35052.8 35900.8 39553.8 39849.4 39864.4 39983.6 40062.4 8326.8 8487.7 8545.4 8600.9 8602.7 7536.6 7687.3 9927.1 10097.1 10118.0 9769.8 9846.6 9850.7 9853.3 9861.3 7566.0 7729.6 9911.5 10001.5 10030.2 9986.3 10150.2 10203.4 10208.9 10211.4 36129.5 36590.8 36619.1 36619.5 36659.3 3271.2 3302.1 3337.6 3670.6 4114.6 28161.6 28410.7 30398.8 30863.0 31549.7 3782.8 3829.5 3842.0 3900.3 3984.0 252342.0 258048.0 259596.0 259748.0 261743.0 60292.4 60997.0 61021.7 61072.7 61158.4 63806.0 65478.3 67309.7 68439.0 68636.7 14657.3 14790.6 14801.4 14806.9 14867.3 10637.0 10657.3 10668.2 10685.1 10714.6 20548.0 20666.0 20670.8 20695.0 20709.5 8291.3 8535.4 8538.9 8686.2 8712.3 925.3 974.4 1034.9 1063.8 1065.8 28768.6 29018.1 29040.4 29113.0 30390.0 995.2 1024.9 1058.5 1092.7 1094.7 14261.6 14501.8 14684.7 16209.4 16470.4 368717.0 379063.0 379603.0 379749.0 380051.0 55152.0 55196.2 55596.0 55792.0 56050.4 1310.6 1313.5 1325.8 1330.3 1363.0 27706.0 28810.0 29488.0 29705.4 30265.0 45417.5 46049.9 46063.0 46078.3 46100.3 227906.0 228938.0 229032.0 229243.0 229760.0 28204.6 28654.3 31996.9 32419.5 32482.2 40768.0 40961.6 41217.2 41532.6 41954.6 34169.7 34583.6 34930.7 34971.7 35206.8 32268.5 34969.0 35176.0 37174.4 37728.2 32738.5 33385.5 33979.2 33982.2 33997.3 30158.8 31296.5 32881.8 33675.5 33680.7 24880.9 24927.9 25062.5 25169.0 25456.2 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#2] jquery.html Cycles:180 Average:29170.03 Median:34835.98 stddev:90429.94 (259.6%) stddev-sans-first:90657.72 05:50:12 INFO - PROCESS | 14944 | Values: 344.3 345.5 346.7 349.7 350.6 13584.9 14086.2 16472.3 16593.5 17360.4 16026.0 16370.3 16838.0 17142.3 17193.2 5197.3 5294.3 5295.2 5299.9 5302.4 4033.5 4135.6 5334.8 5814.1 6013.8 5890.1 5919.0 5922.3 5948.1 5970.7 5751.1 5860.4 5861.6 5869.7 5873.3 5127.7 5135.5 5141.0 5166.3 5174.2 18308.4 19001.8 19031.5 19988.8 20033.3 2034.5 2102.6 2261.2 2275.0 2407.4 9252.1 9638.6 12551.8 12886.4 12981.3 1682.6 1749.3 1757.7 1767.3 1819.2 60455.7 64653.0 64680.4 64791.4 64823.0 10195.8 10204.1 10222.2 10232.5 10240.7 13306.9 13454.1 13470.3 13476.0 13487.3 6976.3 7105.7 7123.3 7158.8 7195.0 6717.0 6730.0 6764.2 6779.0 6786.3 4282.8 4349.9 4361.6 4366.8 4402.6 1693.2 1728.2 1774.7 1817.4 1827.5 410.1 414.1 420.2 451.8 839.8 10502.7 10680.1 10988.8 12797.7 16179.5 939.5 951.9 960.6 1012.1 1030.1 9794.7 9955.9 9984.4 10074.5 10081.5 525822.0 534254.0 538577.0 582358.0 582525.0 72957.0 78310.6 80492.6 80815.0 82141.0 1092.0 1113.3 1121.3 1138.8 1162.2 15193.2 15350.1 15458.3 15470.6 15717.9 34790.8 34881.1 35367.3 35733.6 36041.5 46219.3 47960.8 48659.5 49467.3 51091.5 9550.8 9596.5 9722.0 9757.9 9766.4 14742.6 17605.2 17682.6 18219.8 18258.4 14330.7 14402.6 14473.2 14831.7 14922.2 13888.3 14155.9 14465.7 14702.5 14902.5 11650.8 13469.1 13834.4 13857.9 13925.9 9040.2 9133.9 9206.7 9264.6 9295.5 13070.0 13087.5 13340.2 13368.5 14429.3 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#3] mootools.html Cycles:180 Average:4847.52 Median:5902.40 stddev:2425.47 (41.1%) stddev-sans-first:2417.15 05:50:12 INFO - PROCESS | 14944 | Values: 1243.4 1412.7 1423.6 1504.8 1761.8 6012.8 6634.3 6720.6 6733.4 6739.5 6407.4 6546.0 6546.2 6550.2 6552.7 1871.9 1907.9 1908.4 2096.8 2132.4 1889.8 2100.4 2140.7 2147.9 2151.9 2105.4 2113.0 2121.9 2134.3 2135.2 2104.5 2114.4 2136.6 2139.9 2142.2 2157.8 2174.3 2189.5 2190.1 2191.1 6766.1 6772.3 6840.7 6857.3 6867.6 4220.7 4289.4 4296.8 4297.4 4302.3 2811.2 2882.4 2896.4 2902.3 2911.7 948.4 983.6 991.1 1016.8 1037.1 9224.7 9263.4 9264.3 9271.0 9272.5 3647.4 3687.8 3710.8 3713.4 3728.2 7911.8 7958.5 7985.0 8005.0 8025.4 4195.2 4207.0 4210.4 4218.0 4223.4 3847.6 3855.3 3884.2 3886.6 3886.6 3088.4 3135.8 3155.4 3175.0 3185.8 1057.1 1072.3 1077.0 1082.5 1089.6 1073.9 1076.6 1111.9 1223.3 1328.2 6369.6 6373.2 6452.8 6475.4 6476.5 1081.9 1084.3 1094.5 1104.6 1114.3 5292.4 5408.3 5408.6 5412.6 5413.3 7884.6 8067.3 8236.5 8284.6 8304.9 8132.1 8230.1 8238.2 8239.2 8243.3 6472.8 6548.9 6602.0 6622.8 6626.6 6414.7 6436.6 6437.0 6442.7 6447.0 7075.4 7289.8 7383.6 7450.1 7474.5 7253.9 7430.5 7433.5 7467.6 7570.2 5733.7 5792.5 5802.9 5807.0 5808.7 6581.8 6644.7 6669.2 6690.7 6704.2 6317.7 6388.8 6400.0 6443.0 6528.8 5915.7 6002.5 6051.4 6121.9 6401.5 6116.2 6144.8 6159.6 6196.5 6287.8 5861.4 5881.5 5895.6 5898.1 5906.7 5953.7 5978.3 5982.4 5988.6 5997.1 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#4] prototype.html Cycles:180 Average:5258.19 Median:5997.80 stddev:1604.84 (26.8%) stddev-sans-first:1565.82 05:50:12 INFO - PROCESS | 14944 | Values: 312.5 318.1 320.0 327.8 333.2 5741.0 5890.2 5925.4 5926.2 5933.9 5693.7 5814.9 5822.7 5829.5 5831.0 4569.2 4572.3 4573.2 4575.8 4580.7 4339.6 4435.7 4435.9 4473.5 4565.6 4373.2 4461.2 4472.5 4472.8 4493.2 4477.3 4481.0 4484.2 4486.5 4502.6 3921.4 3921.7 3922.9 3929.5 3929.6 5405.0 5579.6 5584.5 5610.8 5621.3 5173.2 5182.5 5184.2 5185.4 5189.7 5977.4 6235.1 6235.5 6250.4 6250.5 4179.9 4253.8 4258.3 4258.3 4283.4 6429.1 6525.9 6527.9 6528.2 6536.9 4384.6 4384.8 4385.4 4387.9 4388.6 4401.2 4401.2 4434.5 4439.0 4554.2 5236.0 5263.1 5268.3 5269.8 5274.2 6335.2 6345.2 6347.4 6347.5 6351.4 1567.5 1575.3 1576.6 1577.6 1579.3 1036.0 1036.3 1050.7 1061.7 1109.7 6018.2 6022.0 6023.7 6025.5 6029.5 6469.0 6472.8 6473.4 6476.4 6490.9 6043.9 6067.6 6072.8 6073.4 6077.3 3432.6 3524.6 3527.3 3530.3 3535.9 6833.9 6836.0 6837.0 6838.6 6850.9 6650.5 6650.8 6651.5 6652.8 6654.1 6602.6 6789.2 6797.1 6817.5 6826.1 6257.3 6402.8 6503.4 6509.3 6510.2 6345.7 6480.9 6491.0 6500.3 6516.8 6787.6 6803.3 6804.3 6807.1 6817.8 4430.1 4469.7 4496.4 4507.4 4507.5 6535.1 6550.9 6554.2 6561.0 6576.7 6359.5 6375.9 6377.6 6380.3 6388.6 6238.2 6361.5 6362.1 6366.8 6367.8 6244.7 6256.1 6258.2 6258.5 6261.9 6354.1 6383.2 6398.0 6400.4 6404.0 6085.5 6192.7 6228.2 6239.3 6239.8 05:50:12 INFO - PROCESS | 14944 | 05:50:12 INFO - PROCESS | 14944 | [#5] yui.html Cycles:180 Average:13554.45 Median:44307.56 stddev:15506.79 (35.0%) stddev-sans-first:15520.52 05:50:12 INFO - PROCESS | 14944 | Values: 760.5 839.6 853.1 856.8 859.9 13010.7 13257.7 13258.5 13266.7 13277.9 11551.4 12782.1 12887.4 12890.5 12894.5 662.9 802.8 825.5 830.2 830.5 829.4 839.4 840.9 841.2 841.6 722.0 736.2 868.1 877.3 879.1 860.0 863.4 871.1 874.0 874.5 634.9 636.1 637.7 639.1 639.4 13632.6 13636.7 13707.3 13766.4 13771.1 12116.6 12278.6 12307.5 12326.1 12531.9 10319.9 10337.4 10497.2 10620.8 10842.1 3605.6 3663.9 3696.6 3820.8 3827.9 43521.8 44156.4 44390.1 44443.0 44487.3 9895.8 10251.1 10369.0 10436.5 10503.7 17794.4 17982.1 18032.5 18585.3 18762.3 7438.0 7639.3 7661.4 7781.5 8189.9 4254.8 4279.4 4380.6 4417.8 4522.8 3068.5 3100.7 3102.6 3106.0 3113.1 541.2 550.1 552.4 556.1 569.1 462.8 501.3 526.5 593.9 598.9 7459.8 7482.9 7682.2 7693.5 7727.6 588.6 595.2 595.8 607.4 620.3 3729.9 3854.6 3906.6 4050.0 4168.5 55126.4 55326.2 55525.7 57495.0 60312.0 49653.0 50130.2 50213.2 50276.7 50414.7 45342.0 45472.8 45765.5 46269.8 46737.0 8184.5 8388.2 8402.2 8420.2 8600.7 34228.0 34346.8 35038.3 35105.8 35156.6 40991.0 41838.4 43866.8 44225.0 46616.5 10567.1 10871.3 10923.5 11163.2 11224.8 11096.6 11200.8 11227.8 12061.5 12474.9 11611.4 11686.5 11695.3 11761.5 12072.3 11246.1 11493.8 11689.7 11858.9 11951.6 10906.2 11165.2 11368.7 11583.9 11603.7 9384.6 9699.8 9786.1 10050.1 10285.3 8809.3 8934.8 9129.3 9651.0 9899.6 05:50:12 INFO - PROCESS | 14944 | -------- Summary: end -------- 05:50:12 INFO - PROCESS | 14944 | 05:50:13 INFO - TEST-INFO | 14944: exit 0 05:50:13 INFO - TEST-OK | dromaeo_css | took 1114174ms 05:50:13 INFO - TEST-START | kraken 05:50:13 INFO - operating with platform_type : linux_ 05:50:13 INFO - Initialising browser for kraken test... 05:50:13 INFO - TEST-INFO | started process 15136 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDd7VFt/profile http://localhost:48105/getInfo.html) 05:50:17 INFO - PROCESS | 15136 | __metrics Screen width/height:1600/1200 05:50:17 INFO - PROCESS | 15136 | colorDepth:24 05:50:17 INFO - PROCESS | 15136 | Browser inner width/height: 1024/697 05:50:17 INFO - PROCESS | 15136 | __metrics 05:50:18 INFO - PROCESS | 15136 | 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:18 INFO - PROCESS | 15136 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:50:19 INFO - TEST-INFO | 15136: exit 0 05:50:19 INFO - Browser initialized. 05:50:19 INFO - Running cycle 1/1 for kraken test... 05:50:19 INFO - TEST-INFO | started process 15223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDd7VFt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:30 INFO - PROCESS | 15223 | RSS: Main: 150212608 05:50:30 INFO - PROCESS | 15223 | 05:50:33 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48105/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:33 INFO - PROCESS | 15223 | RSS: Main: 185024512 05:50:33 INFO - PROCESS | 15223 | 05:50:36 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48105/tests/kraken/driver.html?testName=audio-dft) 05:50:37 INFO - PROCESS | 15223 | RSS: Main: 176803840 05:50:37 INFO - PROCESS | 15223 | 05:50:40 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48105/tests/kraken/driver.html?testName=audio-fft) 05:50:40 INFO - PROCESS | 15223 | RSS: Main: 161091584 05:50:40 INFO - PROCESS | 15223 | 05:50:42 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48105/tests/kraken/driver.html?testName=audio-oscillator) 05:50:43 INFO - PROCESS | 15223 | RSS: Main: 162885632 05:50:43 INFO - PROCESS | 15223 | 05:50:45 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:45 INFO - PROCESS | 15223 | RSS: Main: 165089280 05:50:45 INFO - PROCESS | 15223 | 05:50:48 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48105/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:49 INFO - PROCESS | 15223 | RSS: Main: 164995072 05:50:49 INFO - PROCESS | 15223 | 05:50:52 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48105/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:53 INFO - PROCESS | 15223 | RSS: Main: 166739968 05:50:53 INFO - PROCESS | 15223 | 05:50:56 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48105/tests/kraken/driver.html?testName=json-parse-financial) 05:50:56 INFO - PROCESS | 15223 | RSS: Main: 165167104 05:50:56 INFO - PROCESS | 15223 | 05:50:58 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:58 INFO - PROCESS | 15223 | RSS: Main: 176889856 05:50:58 INFO - PROCESS | 15223 | 05:51:00 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:51:01 INFO - PROCESS | 15223 | RSS: Main: 175992832 05:51:01 INFO - PROCESS | 15223 | 05:51:03 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:51:03 INFO - PROCESS | 15223 | RSS: Main: 188723200 05:51:03 INFO - PROCESS | 15223 | 05:51:06 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:51:06 INFO - PROCESS | 15223 | RSS: Main: 196431872 05:51:06 INFO - PROCESS | 15223 | 05:51:09 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:51:10 INFO - PROCESS | 15223 | RSS: Main: 194789376 05:51:10 INFO - PROCESS | 15223 | 05:51:11 INFO - PROCESS | 15223 | Cycle 1(1): loaded http://localhost:48105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48105/tests/kraken/driver.html?testName=ai-astar) 05:51:12 INFO - PROCESS | 15223 | RSS: Main: 252461056 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | __start_tp_report 05:51:12 INFO - PROCESS | 15223 | _x_x_mozilla_page_load 05:51:12 INFO - PROCESS | 15223 | _x_x_mozilla_page_load_details 05:51:12 INFO - PROCESS | 15223 | |i|pagename|runs| 05:51:12 INFO - PROCESS | 15223 | |0;ai-astar;110;112;107;112;114;112;102;111;110;119 05:51:12 INFO - PROCESS | 15223 | |1;audio-beat-detection;150;136;156;159;127;152;151;124;163;129 05:51:12 INFO - PROCESS | 15223 | |2;audio-dft;160;162;161;162;160;160;160;162;161;160 05:51:12 INFO - PROCESS | 15223 | |3;audio-fft;71;74;83;91;71;74;72;100;97;72 05:51:12 INFO - PROCESS | 15223 | |4;audio-oscillator;97;96;139;96;95;96;139;98;96;140 05:51:12 INFO - PROCESS | 15223 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;110 05:51:12 INFO - PROCESS | 15223 | |6;imaging-darkroom;147;145;145;144;146;145;145;145;145;145 05:51:12 INFO - PROCESS | 15223 | |7;imaging-desaturate;96;97;96;96;96;95;96;95;95;95 05:51:12 INFO - PROCESS | 15223 | |8;json-parse-financial;59;60;59;60;60;59;62;70;58;57 05:51:12 INFO - PROCESS | 15223 | |9;json-stringify-tinderbox;68;68;67;67;68;68;68;68;67;68 05:51:12 INFO - PROCESS | 15223 | |10;stanford-crypto-aes;86;87;87;87;88;87;89;95;86;85 05:51:12 INFO - PROCESS | 15223 | |11;stanford-crypto-ccm;125;115;120;130;117;132;121;125;120;119 05:51:12 INFO - PROCESS | 15223 | |12;stanford-crypto-pbkdf2;146;152;156;153;156;142;151;156;151;146 05:51:12 INFO - PROCESS | 15223 | |13;stanford-crypto-sha256-iterative;71;68;67;68;68;67;69;66;67;69 05:51:12 INFO - PROCESS | 15223 | __end_tp_report 05:51:12 INFO - PROCESS | 15223 | __start_cc_report 05:51:12 INFO - PROCESS | 15223 | _x_x_mozilla_cycle_collect,959 05:51:12 INFO - PROCESS | 15223 | __end_cc_report 05:51:12 INFO - PROCESS | 15223 | __startTimestamp1452001872017__endTimestamp 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | ------- Summary: start ------- 05:51:12 INFO - PROCESS | 15223 | Number of tests: 14 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:4.41 (3.9%) stddev-sans-first:4.66 05:51:12 INFO - PROCESS | 15223 | Values: 110.0 112.0 107.0 112.0 114.0 112.0 102.0 111.0 110.0 119.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:14.35 (9.5%) stddev-sans-first:15.09 05:51:12 INFO - PROCESS | 15223 | Values: 150.0 136.0 156.0 159.0 127.0 152.0 151.0 124.0 163.0 129.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 05:51:12 INFO - PROCESS | 15223 | Values: 160.0 162.0 161.0 162.0 160.0 160.0 160.0 162.0 161.0 160.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:11.44 (15.5%) stddev-sans-first:11.61 05:51:12 INFO - PROCESS | 15223 | Values: 71.0 74.0 83.0 91.0 71.0 74.0 72.0 100.0 97.0 72.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:20.81 (21.7%) stddev-sans-first:21.60 05:51:12 INFO - PROCESS | 15223 | Values: 97.0 96.0 139.0 96.0 95.0 96.0 139.0 98.0 96.0 140.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:51:12 INFO - PROCESS | 15223 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.50 05:51:12 INFO - PROCESS | 15223 | Values: 147.0 145.0 145.0 144.0 146.0 145.0 145.0 145.0 145.0 145.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:51:12 INFO - PROCESS | 15223 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.00 stddev:3.63 (6.0%) stddev-sans-first:3.81 05:51:12 INFO - PROCESS | 15223 | Values: 59.0 60.0 59.0 60.0 60.0 59.0 62.0 70.0 58.0 57.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:51:12 INFO - PROCESS | 15223 | Values: 68.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:2.79 (3.2%) stddev-sans-first:2.89 05:51:12 INFO - PROCESS | 15223 | Values: 86.0 87.0 87.0 87.0 88.0 87.0 89.0 95.0 86.0 85.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:123.00 stddev:5.50 (4.5%) stddev-sans-first:5.75 05:51:12 INFO - PROCESS | 15223 | Values: 125.0 115.0 120.0 130.0 117.0 132.0 121.0 125.0 120.0 119.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:152.50 stddev:4.84 (3.2%) stddev-sans-first:4.80 05:51:12 INFO - PROCESS | 15223 | Values: 146.0 152.0 156.0 153.0 156.0 142.0 151.0 156.0 151.0 146.0 05:51:12 INFO - PROCESS | 15223 | 05:51:12 INFO - PROCESS | 15223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.41 (2.1%) stddev-sans-first:1.00 05:51:12 INFO - PROCESS | 15223 | Values: 71.0 68.0 67.0 68.0 68.0 67.0 69.0 66.0 67.0 69.0 05:51:12 INFO - PROCESS | 15223 | -------- Summary: end -------- 05:51:12 INFO - PROCESS | 15223 | 05:51:13 INFO - TEST-INFO | 15223: exit 0 05:51:13 INFO - TEST-OK | kraken | took 59896ms 05:51:13 INFO - TEST-START | v8_7 05:51:13 INFO - operating with platform_type : linux_ 05:51:13 INFO - Initialising browser for v8_7 test... 05:51:13 INFO - TEST-INFO | started process 15472 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiTv2qG/profile http://localhost:48105/getInfo.html) 05:51:17 INFO - PROCESS | 15472 | __metrics Screen width/height:1600/1200 05:51:17 INFO - PROCESS | 15472 | colorDepth:24 05:51:17 INFO - PROCESS | 15472 | Browser inner width/height: 1024/697 05:51:17 INFO - PROCESS | 15472 | __metrics 05:51:17 INFO - PROCESS | 15472 | 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:51:17 INFO - PROCESS | 15472 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:19 INFO - TEST-INFO | 15472: exit 0 05:51:19 INFO - Browser initialized. 05:51:19 INFO - Running cycle 1/1 for v8_7 test... 05:51:19 INFO - TEST-INFO | started process 15556 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiTv2qG/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:30 INFO - PROCESS | 15556 | RSS: Main: 150360064 05:51:30 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | Cycle 1(1): loaded http://localhost:48105/tests/v8_7/run.html (next: http://localhost:48105/tests/v8_7/run.html) 05:51:52 INFO - PROCESS | 15556 | RSS: Main: 566284288 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | __start_tp_report 05:51:52 INFO - PROCESS | 15556 | _x_x_mozilla_page_load 05:51:52 INFO - PROCESS | 15556 | _x_x_mozilla_page_load_details 05:51:52 INFO - PROCESS | 15556 | |i|pagename|runs| 05:51:52 INFO - PROCESS | 15556 | |0;Richards;167.7008217340265 05:51:52 INFO - PROCESS | 15556 | |1;DeltaBlue;190.00570017100512 05:51:52 INFO - PROCESS | 15556 | |2;Encrypt;280.8199943836001 05:51:52 INFO - PROCESS | 15556 | |3;Decrypt;5175.257731958763 05:51:52 INFO - PROCESS | 15556 | |4;RayTrace;1100.1100110011 05:51:52 INFO - PROCESS | 15556 | |5;Earley;786.7820613690008 05:51:52 INFO - PROCESS | 15556 | |6;Boyer;12444.444444444445 05:51:52 INFO - PROCESS | 15556 | |7;RegExp;25666.666666666668 05:51:52 INFO - PROCESS | 15556 | |8;Splay;585.1375073142189 05:51:52 INFO - PROCESS | 15556 | |9;NavierStokes;4859.223300970873 05:51:52 INFO - PROCESS | 15556 | __end_tp_report 05:51:52 INFO - PROCESS | 15556 | __startTimestamp1452001912579__endTimestamp 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | ------- Summary: start ------- 05:51:52 INFO - PROCESS | 15556 | Number of tests: 10 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 167.7 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 190.0 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#2] Encrypt Cycles:1 Average:280.82 Median:280.82 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 280.8 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 5175.3 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#4] RayTrace Cycles:1 Average:1100.11 Median:1100.11 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 1100.1 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 786.8 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 12444.4 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 25666.7 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#8] Splay Cycles:1 Average:585.14 Median:585.14 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 585.1 05:51:52 INFO - PROCESS | 15556 | 05:51:52 INFO - PROCESS | 15556 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 05:51:52 INFO - PROCESS | 15556 | Values: 4859.2 05:51:52 INFO - PROCESS | 15556 | -------- Summary: end -------- 05:51:52 INFO - PROCESS | 15556 | 05:51:53 INFO - TEST-INFO | 15556: exit 0 05:51:53 INFO - TEST-OK | v8_7 | took 40444ms 05:51:53 INFO - SUITE-END | took 1214s 05:51:53 INFO - Completed test suite (00:20:14) 05:51:53 INFO - Working with test: dromaeo_css 05:51:53 INFO - Generating results file: dromaeo_css 05:51:53 INFO - Working with test: kraken 05:51:53 INFO - Generating results file: kraken 05:51:53 INFO - javascript benchmark 05:51:53 INFO - Working with test: v8_7 05:51:53 INFO - Generating results file: v8_7 05:51:53 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 05:51:53 INFO - process_Request line: dromaeo_css 6793.04 graph.html#tests=[[72,1,35]] 05:51:53 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:53 INFO - process_Request line: kraken 1513.20 graph.html#tests=[[232,1,35]] 05:51:53 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:53 INFO - process_Request line: v8_7 21054.82 graph.html#tests=[[230,1,35]] 05:51:53 INFO - RETURN: dromaeo_css: 6793.04 05:51:53 INFO - RETURN: kraken: 1513.20 05:51:53 INFO - RETURN: v8_7: 21054.82 05:51:53 INFO - javascript benchmark 05:51:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3059.3269480714243, 3091.7217450429457, 3131.1702398864304, 3133.576967109441, 3166.9366612667745, 5061.54446099851, 5133.7946482140715, 5150.484951504857, 5166.354205724279, 5199.896002079956, 5117.2068329409, 5120.975804839038, 5204.193350030741, 5281.841544753664, 5304.734763261831, 4637.513061128592, 4729.1251118543005, 4741.90516189676, 4804.183288840888, 4899.216125419934, 4739.0, 4816.686915350491, 4862.416510018803, 4869.853904382874, 4898.828541001066, 4652.581267685924, 4746.620270378361, 4823.999999999983, 4860.222364421711, 4880.8047678092835, 4726.1020406122725, 4728.503507131771, 4736.029114031615, 4741.31250968611, 4744.525547445262, 4709.340692303081, 4709.62323014158, 4710.8351207707565, 4714.962708204224, 4720.457147428056, 5001.17480615698, 5024.321716568253, 5154.407243167008, 5157.742112894378, 5187.118189907687, 5573.498385145316, 5576.693281869536, 5582.134769110794, 5584.581156413245, 5587.078132108198, 5407.324084489439, 5553.722313884289, 5602.327720673546, 5609.915851262234, 5620.325560932673, 5204.973975130138, 5226.320578324831, 5238.030964271622, 5323.387810401815, 5356.866078348073, 5704.201411802351, 5755.654660720286, 5785.595008349459, 5795.1017592273265, 5810.6513609183585, 5519.475649813261, 5520.779168833202, 5523.861903452365, 5524.917126243109, 5525.0883604204855, 5458.426865179178, 5567.0, 5579.023670857665, 5579.9163012554845, 5650.74571644277, 5594.580406469531, 5620.241267428926, 5634.3802181759975, 5638.520725738276, 5642.605017648807, 5577.888442231133, 5586.91619625706, 5592.440755924456, 5595.18869763882, 5602.803901863415, 4235.512916014636, 4334.371516130143, 4350.0647360817575, 4356.629686476685, 4396.824127034883, 3808.1622043150464, 3848.499695039683, 3903.375459926398, 3933.586973367755, 3949.92100158001, 5231.346081739783, 5261.053010458154, 5266.236395722675, 5272.340957380327, 5274.736263186825, 5472.945270547323, 5593.804216852391, 5628.887422251532, 5630.23991761107, 5630.775201898865, 5214.165733482625, 5258.500442458037, 5264.078786212397, 5279.44565820591, 5325.813596524103, 4474.977625111854, 4797.664163508591, 4798.8560343189065, 4809.110314591811, 4842.612590992712, 5614.382417934024, 5741.540676745851, 5749.540036797046, 5807.651540907559, 5808.128780682847, 5587.245721827664, 5673.120666296731, 5678.886422271614, 5689.374168841507, 5725.7137143141845, 5842.883142337045, 5848.298204215522, 5848.707564621837, 5850.736716847837, 5857.062869940789, 5413.269208656781, 5491.039068163135, 5531.502164805187, 5537.390887002507, 5555.055640541037, 5634.380218176079, 5690.573207009574, 5697.658140511582, 5699.829005129853, 5745.971270143623, 5269.71016594091, 5489.258950041693, 5494.203340515683, 5499.477549632778, 5501.889962200654, 5159.09715799741, 5239.266502689703, 5434.0490414176575, 5464.28964234647, 5510.1459273812625, 5448.264484294569, 5452.291202143696, 5455.618106732491, 5459.5632349412745, 5474.644148130359, 5512.614117011771, 5514.145307477347, 5515.0, 5548.889022219452, 5551.306086739158, 5267.841964741064, 5323.334583177103, 5371.248025276386, 5379.273798037215, 5421.566274698093], "unit": "score", "name": "dojo.html", "value": 5162.566972972986}, {"lowerIsBetter": false, "replicates": [529.7060131626948, 537.373959337372, 555.9416261292562, 559.6502186133667, 573.8393249890032, 27696.30759231018, 28434.71565284349, 28443.14670559884, 35052.82473587628, 35900.82049589755, 39553.802230988804, 39849.40225896614, 39864.40203396944, 39983.60016399835, 40062.39906401406, 8326.791830204233, 8487.702930397438, 8545.444546104483, 8600.8709869352, 8602.741917742447, 7536.5854877981965, 7687.346575541058, 9927.106560409562, 10097.091261786438, 10118.0, 9769.755756106084, 9846.606135754597, 9850.655227067055, 9853.261005424622, 9861.260405469582, 7565.962170189169, 7729.613519324012, 9911.504424778732, 10001.49992500372, 10030.197584193284, 9986.251031172691, 10150.187984961185, 10203.4388108654, 10208.89791102087, 10211.438370889598, 36129.45805812915, 36590.8170459146, 36619.08452288714, 36619.4507082394, 36659.266814663555, 3271.1985563536846, 3302.1414432247548, 3337.5828021497314, 3670.5778835433734, 4114.567970363129, 28161.577576336167, 28410.71589284122, 30398.848005759828, 30863.0, 31549.684503154906, 3782.8108594570162, 3829.5021647185686, 3842.020284827379, 3900.278448487039, 3983.98008009961, 252342.0, 258048.0, 259596.0, 259748.0, 261742.9999999981, 60292.397076029556, 60996.99999999911, 61021.694891526146, 61072.69463652653, 61158.38841611616, 63806.0, 65478.345216547226, 67309.66345168243, 68439.0, 68636.6568167156, 14657.267136643126, 14790.63023424423, 14801.407943682347, 14806.851931480764, 14867.256637168099, 10637.042666159929, 10657.253992220625, 10668.199885008655, 10685.091767199876, 10714.571417143226, 20548.0, 20666.0, 20670.79329206719, 20695.0, 20709.482262943548, 8291.295239904555, 8535.445196062235, 8538.87191692125, 8686.218240358397, 8712.259093968883, 925.287528602972, 974.4299584742863, 1034.8602938603342, 1063.8297872340388, 1065.7974984753027, 28768.568471472943, 29018.12945611635, 29040.41919161605, 29113.0, 30390.0, 995.1789773436943, 1024.9180065594735, 1058.4813441413653, 1092.6831218946415, 1094.715374002749, 14261.572152835432, 14501.782473262909, 14684.706305873822, 16209.432669856498, 16470.42353517621, 368717.0, 379063.0, 379603.0, 379749.0, 380051.0, 55152.0, 55196.17205741917, 55596.0, 55792.0, 56050.43949560534, 1310.5675127207999, 1313.481174935895, 1325.8342707161605, 1330.255057167989, 1362.9795553066513, 27706.0, 28810.0, 29488.0, 29705.405891881608, 30265.0, 45417.54582454133, 46049.934507203514, 46063.0, 46078.30882536698, 46100.30849537192, 227906.0, 228938.0, 229032.0, 229243.0, 229760.0, 28204.576931345637, 28654.283642909093, 31996.880109196067, 32419.513707294882, 32482.187945301557, 40768.0, 40961.590384095776, 41217.1756564873, 41532.58467415287, 41954.580454195064, 34169.65830341665, 34583.632892877904, 34930.65069349376, 34971.65028349684, 35206.82396588001, 32268.515972260906, 34969.0, 35176.0, 37174.442383363734, 37728.245435091696, 32738.50892236666, 33385.499217512246, 33979.15052123717, 33982.150446239044, 33997.32005359929, 30158.84920575383, 31296.53363387536, 32881.835590821895, 33675.49486757652, 33680.66319336775, 24880.875595621907, 24927.875360623082, 25062.49875002526, 25169.0, 25456.23631291064], "unit": "score", "name": "ext.html", "value": 18432.5712452253}, {"lowerIsBetter": false, "replicates": [344.340587774412, 345.481777333999, 346.7053004945795, 349.7499288009073, 350.6405933917734, 13584.864151358483, 14086.225257610828, 16472.258748356322, 16593.5065844074, 17360.39238626648, 16026.0, 16370.263338149782, 16838.0, 17142.314307427718, 17193.226304816282, 5197.272381866533, 5294.258803767476, 5295.232191332255, 5299.947000529984, 5302.416734159239, 4033.495813023372, 4135.565765594614, 5334.813281535147, 5814.069748840187, 6013.75944962201, 5890.116482527612, 5919.0, 5922.289325280973, 5948.1375200595885, 5970.731317090741, 5751.137329400582, 5860.413958604148, 5861.648301101947, 5869.735861886204, 5873.2658417697785, 5127.692338459704, 5135.537801597837, 5140.974295128501, 5166.250893620404, 5174.197999310113, 18308.359207427675, 19001.809981900144, 19031.524211894673, 19988.80011199884, 20033.29883454072, 2034.511717187879, 2102.621528124937, 2261.185973049701, 2275.0444813178337, 2407.3981504623844, 9252.074792520762, 9638.614455421775, 12551.811722824164, 12886.355682215946, 12981.286029268387, 1682.5709444091679, 1749.2915369275463, 1757.745126956597, 1767.2842498788011, 1819.2086442397467, 60455.69772151155, 64653.03020454697, 64680.35319646837, 64791.352086479004, 64823.0, 10195.796084078425, 10204.132648724793, 10222.233332500093, 10232.53953572091, 10240.692779216635, 13306.866931330564, 13454.058215924988, 13470.259135747629, 13476.0, 13487.25820079905, 6976.267491913378, 7105.71577136919, 7123.25205853378, 7158.785236442915, 7195.0, 6717.0, 6729.966350168218, 6764.2221144569, 6778.966105169443, 6786.287439818847, 4282.785860706952, 4349.913001740011, 4361.629261512743, 4366.759828209479, 4402.5597440255715, 1693.2041940288045, 1728.2050256881976, 1774.7160454327245, 1817.4275103342404, 1827.4974382045043, 410.1468944595235, 414.1427245601576, 420.1932290003201, 451.7515366548385, 839.8446287436843, 10502.737431564272, 10680.145588352912, 10988.780224395467, 12797.680057998437, 16179.514614561582, 939.4504215034145, 951.900050494702, 960.644561512245, 1012.1396812709138, 1030.1449796668746, 9794.65718699842, 9955.900440995641, 9984.400935943866, 10074.496275186211, 10081.49592520371, 525822.0, 534254.0, 538577.0, 582358.0, 582525.0, 72957.0, 78310.60844695853, 80492.5975370131, 80815.0, 82141.0, 1091.9945400272948, 1113.3375641493299, 1121.2823792772633, 1138.834868944015, 1162.2155045344527, 15193.164375959428, 15350.07899526032, 15458.29958704519, 15470.613234669223, 15717.921410392875, 34790.82604586961, 34881.12797180091, 35367.29265414626, 35733.64266357303, 36041.459378109874, 46219.3067103987, 47960.7601961988, 48659.5134048655, 49467.25799113088, 51091.489085108675, 9550.808983820145, 9596.520173991134, 9722.0, 9757.853632195382, 9766.414015159113, 14742.557723268319, 17605.207765650834, 17682.64634707273, 18219.817801821813, 18258.36095736643, 14330.713385732435, 14402.567922962327, 14473.21992117802, 14831.703365932837, 14922.179280139697, 13888.305584720925, 14155.858441415454, 14465.710685786436, 14702.485413010494, 14902.478413255483, 11650.825237621273, 13469.12450690702, 13834.446622135001, 13857.861421385656, 13925.860741392456, 9040.231580315747, 9133.949595796303, 9206.677766278148, 9264.583093760662, 9295.488748118918, 13070.0, 13087.476500939856, 13340.19958802475, 13368.465261389436, 14429.278536073365], "unit": "score", "name": "jquery.html", "value": 8658.043735629415}, {"lowerIsBetter": false, "replicates": [1243.359669770069, 1412.710394369154, 1423.6440889777555, 1504.7667611520212, 1761.832625900539, 6012.7594896204155, 6634.303398143192, 6720.596764194146, 6733.39399454049, 6739.46084313255, 6407.423331900128, 6546.0, 6546.18172728409, 6550.181227346582, 6552.705128269227, 1871.9251229950853, 1907.8759880607786, 1908.3893154190664, 2096.800803923629, 2132.445564153316, 1889.763779527559, 2100.401385605103, 2140.67889816528, 2147.903344349508, 2151.87088774674, 2105.3683894831565, 2113.0280071167203, 2121.86207896487, 2134.3276867786676, 2135.1779564867484, 2104.547522282709, 2114.38682781993, 2136.604728125302, 2139.935801925945, 2142.1645558232303, 2157.8057974782346, 2174.3259589527297, 2189.4745261137373, 2190.0582749417745, 2191.1016483241956, 6766.086578311914, 6772.255051944282, 6840.657967101674, 6857.27998560149, 6867.622280774555, 4220.704550681454, 4289.356596510517, 4296.8281268749215, 4297.376880352363, 4302.311630139194, 2811.1707046421357, 2882.423515296949, 2896.435195136949, 2902.259923719459, 2911.694272101441, 948.3645957208687, 983.5623147699276, 991.0584944302941, 1016.8068067067234, 1037.092544023979, 9224.677136300264, 9263.444193348421, 9264.305177111677, 9271.026542213038, 9272.490013049279, 3647.4164133738473, 3687.778733276012, 3710.7773533587533, 3713.3687273163628, 3728.2357116790995, 7911.762647120596, 7958.482698624571, 7984.960075199703, 8004.959975200087, 8025.3980951428875, 4195.223883581547, 4207.0, 4210.431591735077, 4218.029853133797, 4223.366495025771, 3847.576766555677, 3855.2867719471988, 3884.2037382336553, 3886.553046399644, 3886.591907849635, 3088.382323535302, 3135.8275294858545, 3155.4320222360197, 3175.0, 3185.792923459968, 1057.0750593230923, 1072.2762135558467, 1076.9515371808288, 1082.4641802307908, 1089.5587287148717, 1073.8711354637494, 1076.590895459736, 1111.8943700348455, 1223.2782658231686, 1328.1964411531078, 6369.5541312108635, 6373.171487706569, 6452.838489071918, 6475.384838440341, 6476.481881449473, 1081.8809930907594, 1084.3060441317564, 1094.5293523784849, 1104.6354702948008, 1114.2812885688686, 5292.44429334922, 5408.296921400193, 5408.567314614821, 5412.621116521885, 5413.296271484682, 7884.605769711491, 8067.273945344947, 8236.50580965144, 8284.627191776384, 8304.875426868603, 8132.064812546633, 8230.135835737161, 8238.176182381714, 8239.217274358927, 8243.299319557786, 6472.773452929125, 6548.9017664735065, 6602.042703807921, 6622.8344291393105, 6626.602403855784, 6414.711337989895, 6436.613803171825, 6437.034444833313, 6442.742290308335, 6447.0, 7075.398591119812, 7289.817754556178, 7383.630818459163, 7450.0687414073245, 7474.476786624884, 7253.927460725326, 7430.517016393917, 7433.479656423999, 7467.551946883204, 7570.1672815989095, 5733.741981610754, 5792.507636850746, 5802.854928626818, 5807.0, 5808.738606762621, 6581.769638062645, 6644.734210631714, 6669.233038200475, 6690.69891854858, 6704.229013663296, 6317.747290108344, 6388.8083357499345, 6400.0, 6442.967785161044, 6528.771492997722, 5915.674637894785, 6002.489788368038, 6051.394860513913, 6121.877562448815, 6401.455876250571, 6116.235470566179, 6144.754209831557, 6159.630422174684, 6196.504279657526, 6287.811365659038, 5861.413858614104, 5881.470667639933, 5895.64626122434, 5898.056310990221, 5906.734196961061, 5953.672548009901, 5978.252718410199, 5982.4316689914385, 5988.640681559121, 5997.070454079625], "unit": "score", "name": "mootools.html", "value": 4048.1354022456167}, {"lowerIsBetter": false, "replicates": [312.47972126409525, 318.10136364769534, 320.04466666999, 327.75290021468305, 333.21195372943, 5741.0240259155935, 5890.175375447441, 5925.407459254078, 5926.199963004993, 5933.910991335128, 5693.658380497162, 5814.883702325951, 5822.737976791044, 5829.504492118175, 5831.0, 4569.200389931765, 4572.291294849287, 4573.153966516188, 4575.816967321303, 4580.748058856761, 4339.566043395651, 4435.68950173488, 4435.911281774363, 4473.530279320673, 4565.6119229865335, 4373.1909596724545, 4461.152381047591, 4472.508024117345, 4472.82108715651, 4493.2136876046725, 4477.283634618478, 4480.977595112036, 4484.215262329096, 4486.506484286726, 4502.594766471017, 3921.372580387153, 3921.686265098785, 3922.941155882664, 3929.4695216146024, 3929.5677475477673, 5404.972975135139, 5579.637323573996, 5584.497395234448, 5610.803621873215, 5621.269234999465, 5173.224016397533, 5182.507661772125, 5184.248283998799, 5185.403678576974, 5189.7405129743365, 5977.3723759005115, 6235.095911092912, 6235.469985051276, 6250.406211409909, 6250.499960003189, 4179.895502612429, 4253.808578613939, 4258.276093064186, 4258.318669012943, 4283.357496375537, 6429.099926010363, 6525.93474065258, 6527.93472065278, 6528.249251336109, 6536.934630653727, 4384.583464570861, 4384.8246070157475, 4385.3641222022625, 4387.912241755147, 4388.5830846069575, 4401.22978478765, 4401.22978478765, 4434.512203657595, 4439.045605194899, 4554.24854898938, 5236.031334203185, 5263.052650522943, 5268.28878101459, 5269.78920843162, 5274.208868669731, 6335.208098987627, 6345.175127233522, 6347.39699728525, 6347.492200624031, 6351.4283714465, 1567.5219058187363, 1575.330484544087, 1576.5822057154862, 1577.6213708709827, 1579.336678594993, 1036.0313107244751, 1036.3056751976194, 1050.7110544600143, 1061.6602687140196, 1109.7447587054862, 6018.21763170785, 6021.969890150521, 6023.728932197974, 6025.517958563304, 6029.487493563009, 6469.0, 6472.805815825533, 6473.417392434703, 6476.35236476358, 6490.902636460457, 6043.909341359883, 6067.605605635619, 6072.817815465543, 6073.362296958844, 6077.3314935357075, 3432.6052503962364, 3524.594671612746, 3527.347440723423, 3530.258645684435, 3535.9469607955903, 6833.863322733617, 6836.042953986446, 6837.042814006043, 6838.589684618939, 6850.862982740317, 6650.501212409089, 6650.800475985729, 6651.467882569383, 6652.767153149616, 6654.13496245485, 6602.60384376939, 6789.1852977643, 6797.116374871235, 6817.454603631698, 6826.112605361272, 6257.28041275241, 6402.807915762534, 6503.414692677682, 6509.349065093453, 6510.18622672166, 6345.714442850175, 6480.8703825922275, 6490.967545162244, 6500.284968653539, 6516.837079072871, 6787.626680532618, 6803.251642319242, 6804.251532331538, 6807.115075040213, 6817.795466136024, 4430.113977204507, 4469.7318160910445, 4496.437945256843, 4507.4365704286965, 4507.526709695435, 6535.117759102651, 6550.868982620416, 6554.213494380514, 6560.967195163994, 6576.704048317742, 6359.491240700825, 6375.87248255023, 6377.585456945284, 6380.298167201511, 6388.616682999035, 6238.189035425366, 6361.522885783492, 6362.0774987627465, 6366.77716279928, 6367.840803979938, 6244.687765611792, 6256.061590761422, 6258.217722784652, 6258.468030217483, 6261.906071409024, 6354.1104245406605, 6383.234011918599, 6398.0083087121575, 6400.407834826902, 6404.039394090923, 6085.482733967485, 6192.690365481798, 6228.159198508143, 6239.282482514387, 6239.78160764371], "unit": "score", "name": "prototype.html", "value": 4732.471389796125}, {"lowerIsBetter": false, "replicates": [760.5018712743154, 839.6347588798873, 853.1127627267642, 856.820067785765, 859.8649782287379, 13010.674733131664, 13257.7348453031, 13258.469661213552, 13266.734665306712, 13277.933610331958, 11551.364674942895, 12782.10525263232, 12887.355632218376, 12890.548830790924, 12894.5486907958, 662.8740539297543, 802.7872613757359, 825.4634487583058, 830.1573902488979, 830.4933990265932, 829.4194064155085, 839.4375768235298, 840.920112589303, 841.2092632925031, 841.6338892581716, 721.9639018049103, 736.1681300130845, 868.1448772958631, 877.302544477139, 879.0901417033372, 859.9828003439959, 863.447393668053, 871.1288711288711, 873.9992708348968, 874.45783614159, 634.9301576826546, 636.141209367355, 637.6811594202899, 639.11163482759, 639.389383139101, 13632.591022269347, 13636.727265454734, 13707.314634268347, 13766.449342026408, 13771.104878182887, 12116.575919842851, 12278.631641050693, 12307.507699692002, 12326.07554433412, 12531.93734031333, 10319.89680103197, 10337.37975721459, 10497.160227181883, 10620.840687389695, 10842.13262938971, 3605.5853576838476, 3663.8900832975055, 3696.6488183622514, 3820.8280627371555, 3827.885163445101, 43521.782391088156, 44156.36358182377, 44390.112197756185, 44443.0, 44487.33269000967, 9895.802083958424, 10251.12865406434, 10369.0, 10436.478176091165, 10503.737406564896, 17794.37719679831, 17982.10089495546, 18032.459026229233, 18585.25658973653, 18762.34331798408, 7438.0, 7639.274268944441, 7661.425393095428, 7781.5331080135375, 8189.8771518427275, 4254.808533615995, 4279.358096285582, 4380.649548036149, 4417.779111044435, 4522.796474158671, 3068.5397190421168, 3100.7209351158504, 3102.550130231104, 3106.0, 3113.1438854314792, 541.2206422751226, 550.1143159513181, 552.4254775034, 556.0824639345113, 569.0894568690063, 462.8310666606664, 501.34073693093467, 526.5050852198921, 593.8782549577327, 598.853280946171, 7459.776206713699, 7482.901704101066, 7682.231776822385, 7693.4614576979075, 7727.5749833758555, 588.6314319207859, 595.1816252652603, 595.7646729541807, 607.3592360060179, 620.2835724737845, 3729.9254014920093, 3854.5759966403675, 3906.5507466641134, 4049.979750101231, 4168.520620128724, 55126.44873551213, 55326.17010744842, 55525.722371387885, 57495.0, 60312.0, 49653.0, 50130.24804627933, 50213.24680129801, 50276.748616256686, 50414.747926260134, 45342.0, 45472.77263613661, 45765.542344576796, 46269.7686511572, 46737.0, 8184.508929464251, 8388.245057944814, 8402.243798058204, 8420.242178203991, 8600.655973760979, 34228.0, 34346.82826585851, 35038.299234015685, 35105.82447087748, 35156.64843351534, 40991.0, 41838.372424414265, 43866.780666097744, 44225.0, 46616.53383466258, 10567.10179634709, 10871.29336593119, 10923.47527316117, 11163.162762792985, 11224.775504490028, 11096.61161859331, 11200.831987520356, 11227.7754444909, 12061.51753929868, 12474.937625311815, 11611.361375124112, 11686.532538698357, 11695.298282103102, 11761.529538818351, 12072.275663460221, 11246.100311975186, 11493.82759258595, 11689.707757306136, 11858.940705296418, 11951.641450756144, 10906.182036347147, 11165.218434709492, 11368.658940231806, 11583.942080289882, 11603.709907252049, 9384.624615015597, 9699.757506062122, 9786.1192492676, 10050.09549140581, 10285.2800303978, 8809.251213646912, 8934.821303573763, 9129.315301352557, 9650.95174524123, 9899.604015839286], "unit": "score", "name": "yui.html", "value": 6224.816787777237}], "name": "dromaeo_css", "value": 6793.037457926773}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 112.0, 114.0, 112.0, 102.0, 111.0, 110.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [150.0, 136.0, 156.0, 159.0, 127.0, 152.0, 151.0, 124.0, 163.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 162.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 83.0, 91.0, 71.0, 74.0, 72.0, 100.0, 97.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 96.0, 95.0, 96.0, 139.0, 98.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 62.0, 70.0, 58.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 87.0, 88.0, 87.0, 89.0, 95.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [125.0, 115.0, 120.0, 130.0, 117.0, 132.0, 121.0, 125.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [146.0, 152.0, 156.0, 153.0, 156.0, 142.0, 151.0, 156.0, 151.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 66.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1513.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [280.8199943836001], "unit": "score", "name": "Encrypt", "value": 947.8705409999999}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1100.1100110011], "unit": "score", "name": "RayTrace", "value": 672.6500009999999}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [585.1375073142189], "unit": "score", "name": "Splay", "value": 139.26811900000004}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 21054.824402551138}]} 05:51:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "21054.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1513.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6793.04"}}} 05:51:53 INFO - Return code: 0 05:51:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:53 INFO - # TBPL SUCCESS # 05:51:53 INFO - Running post-action listener: _resource_record_post_action 05:51:53 INFO - Running post-run listener: _resource_record_post_run 05:51:54 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 20480; Write bytes: 557731840; Read time: 476; Write time: 993412 05:51:54 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 238514176; Read time: 0; Write time: 528520 05:51:54 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 20480; Write bytes: 319217664; Read time: 476; Write time: 464892 05:51:54 INFO - Running post-run listener: _upload_blobber_files 05:51:54 INFO - Blob upload gear active. 05:51:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:51:54 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:54 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:54 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:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:56 INFO - (blobuploader) - INFO - Done attempting. 05:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:51:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:57 INFO - (blobuploader) - INFO - Done attempting. 05:51:57 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:57 INFO - Return code: 0 05:51:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:51:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03848b95242ffed43a775c695582ac2ae4c68bfd55e85236563649a335b4c4404e9783bd1bcb34751f15adf37b4ba0a90b082a61742796550d51cf5d3edb37d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d696eb30f5d43ea7d6e6d5475adb23af7bc3d6b1d4db144ed43f1737636c47dc5bf9a32b2d203a732c4beb83956fcc50f00b88c348d873f8ae4a77243c3330e1"} 05:51:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:51:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:51:57 INFO - Contents: 05:51:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03848b95242ffed43a775c695582ac2ae4c68bfd55e85236563649a335b4c4404e9783bd1bcb34751f15adf37b4ba0a90b082a61742796550d51cf5d3edb37d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d696eb30f5d43ea7d6e6d5475adb23af7bc3d6b1d4db144ed43f1737636c47dc5bf9a32b2d203a732c4beb83956fcc50f00b88c348d873f8ae4a77243c3330e1"} 05:51:57 INFO - Copying logs to upload dir... 05:51:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.873532 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-05 05:51:56.954808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:51:56.958749) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 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/d03848b95242ffed43a775c695582ac2ae4c68bfd55e85236563649a335b4c4404e9783bd1bcb34751f15adf37b4ba0a90b082a61742796550d51cf5d3edb37d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d696eb30f5d43ea7d6e6d5475adb23af7bc3d6b1d4db144ed43f1737636c47dc5bf9a32b2d203a732c4beb83956fcc50f00b88c348d873f8ae4a77243c3330e1"} build_url:https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/NNicrLuETJqAvwd-oZeFQA/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/d03848b95242ffed43a775c695582ac2ae4c68bfd55e85236563649a335b4c4404e9783bd1bcb34751f15adf37b4ba0a90b082a61742796550d51cf5d3edb37d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d696eb30f5d43ea7d6e6d5475adb23af7bc3d6b1d4db144ed43f1737636c47dc5bf9a32b2d203a732c4beb83956fcc50f00b88c348d873f8ae4a77243c3330e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 05:51:56.983532) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:51:56.983848) ========= 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=c6927cf182745ad25b1d38b9000001fe-1451999577.833416-1538668541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004695 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 05:51:57.067255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:51:57.067638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 05:51:57.067994) ========= ========= Total master_lag: 0.21 =========