builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1452869491.98 results: success (0) buildid: 20160115043011 builduid: f0b9728ffb82426bb433d3014e27b376 revision: e1486d83107fc4933982d371828d038ad57682e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.980210) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.981564) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:31.982115) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006343 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.007286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.007683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.022067) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.022473) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.079692) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.080007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.080410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.080760) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 06:51:32-- 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% 220M=0s 2016-01-15 06:51:32 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177468 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.270894) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.271226) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014974 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.321561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.321940) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1486d83107fc4933982d371828d038ad57682e4 --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 e1486d83107fc4933982d371828d038ad57682e4 --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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 06:51:32,491 truncating revision to first 12 chars 2016-01-15 06:51:32,491 Setting DEBUG logging. 2016-01-15 06:51:32,491 attempt 1/10 2016-01-15 06:51:32,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1486d83107f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 06:51:32,788 unpacking tar archive at: mozilla-central-e1486d83107f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.955741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.956106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.964583) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.964895) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 06:51:32.965363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 06:51:32.965745) ========= /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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:51:33 INFO - MultiFileLogger online at 20160115 06:51:33 in /builds/slave/test-pgo 06:51:33 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 06:51:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:51:33 INFO - {'append_to_log': False, 06:51:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:51:33 INFO - 'blob_upload_branch': 'Firefox', 06:51:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:51:33 INFO - 'branch': 'Firefox', 06:51:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:33 INFO - 'config_files': ('talos/linux_config.py',), 06:51:33 INFO - 'default_actions': ('clobber', 06:51:33 INFO - 'read-buildbot-config', 06:51:33 INFO - 'download-and-extract', 06:51:33 INFO - 'populate-webroot', 06:51:33 INFO - 'create-virtualenv', 06:51:33 INFO - 'install', 06:51:33 INFO - 'run-tests'), 06:51:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:33 INFO - 'download_minidump_stackwalk': True, 06:51:33 INFO - 'download_symbols': 'ondemand', 06:51:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:33 INFO - 'installer_path': 'installer.exe', 06:51:33 INFO - 'log_level': 'info', 06:51:33 INFO - 'log_name': 'talos', 06:51:33 INFO - 'log_to_console': True, 06:51:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:51:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:51:33 INFO - 'opt_config_files': (), 06:51:33 INFO - 'pip_index': False, 06:51:33 INFO - 'sps_profile': False, 06:51:33 INFO - 'sps_profile_interval': 0, 06:51:33 INFO - 'suite': 'dromaeojs', 06:51:33 INFO - 'system_bits': '32', 06:51:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:33 INFO - 'title': 'talos-linux64-ix-030', 06:51:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:33 INFO - 'use_talos_json': True, 06:51:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:51:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:33 INFO - 'work_dir': 'build'} 06:51:33 INFO - ##### 06:51:33 INFO - ##### Running clobber step. 06:51:33 INFO - ##### 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: clobber 06:51:33 INFO - rmtree: /builds/slave/test-pgo/build 06:51:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:51:33 INFO - Running post-action listener: _resource_record_post_action 06:51:33 INFO - ##### 06:51:33 INFO - ##### Running read-buildbot-config step. 06:51:33 INFO - ##### 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: read_buildbot_config 06:51:33 INFO - Using buildbot properties: 06:51:33 INFO - { 06:51:33 INFO - "project": "", 06:51:33 INFO - "product": "firefox", 06:51:33 INFO - "script_repo_revision": "production", 06:51:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:51:33 INFO - "repository": "", 06:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:51:33 INFO - "buildid": "20160115043011", 06:51:33 INFO - "pgo_build": "True", 06:51:33 INFO - "basedir": "/builds/slave/test-pgo", 06:51:33 INFO - "buildnumber": 305, 06:51:33 INFO - "slavename": "talos-linux64-ix-030", 06:51:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:51:33 INFO - "platform": "ubuntu64_hw", 06:51:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:51:33 INFO - "branch": "mozilla-central", 06:51:33 INFO - "repo_path": "mozilla-central", 06:51:33 INFO - "revision": "e1486d83107fc4933982d371828d038ad57682e4", 06:51:33 INFO - "stage_platform": "linux64-pgo", 06:51:33 INFO - "builduid": "f0b9728ffb82426bb433d3014e27b376", 06:51:33 INFO - "slavebuilddir": "test" 06:51:33 INFO - } 06:51:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:51:33 INFO - Running post-action listener: _resource_record_post_action 06:51:33 INFO - ##### 06:51:33 INFO - ##### Running download-and-extract step. 06:51:33 INFO - ##### 06:51:33 INFO - Running pre-action listener: _resource_record_pre_action 06:51:33 INFO - Running main action method: download_and_extract 06:51:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:33 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:51:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json 06:51:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json 06:51:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:51:36 INFO - Downloaded 1448 bytes. 06:51:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:51:36 INFO - Using the following test package requirements: 06:51:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:51:36 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:51:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'jsshell-linux-x86_64.zip'], 06:51:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:51:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:51:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:51:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:51:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:51:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:51:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:51:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:51:36 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')]} 06:51:36 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:41 INFO - Downloaded 22440531 bytes. 06:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:42 INFO - Return code: 0 06:51:42 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 06:51:42 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')]} 06:51:42 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:47 INFO - Downloaded 22440531 bytes. 06:51:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:49 INFO - Return code: 0 06:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:49 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:51 INFO - Downloaded 11132144 bytes. 06:51:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:51:51 INFO - Return code: 0 06:51:51 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')]} 06:51:51 INFO - https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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 06:51:56 INFO - Downloaded 55940114 bytes. 06:51:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:56 INFO - mkdir: /builds/slave/test-pgo/properties 06:51:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:51:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:51:56 INFO - Contents: 06:51:56 INFO - build_url:https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:51:56 INFO - Running post-action listener: _resource_record_post_action 06:51:56 INFO - Running post-action listener: set_extra_try_arguments 06:51:56 INFO - ##### 06:51:56 INFO - ##### Running populate-webroot step. 06:51:56 INFO - ##### 06:51:56 INFO - Running pre-action listener: _resource_record_pre_action 06:51:56 INFO - Running main action method: populate_webroot 06:51:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:51:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:51:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:51:56 INFO - '--tppagecycles', 06:51:56 INFO - '7'], 06:51:56 INFO - 'tests': ['tsvgm']}}, 06:51:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:51:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:51:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:51:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:51:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'tests': ['damp', 'tps']}, 06:51:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['damp', 'tps']}, 06:51:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:51:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:51:56 INFO - 'other': {'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'other_l64': {'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'other_nol64': {'tests': ['a11yr', 06:51:56 INFO - 'ts_paint', 06:51:56 INFO - 'tpaint', 06:51:56 INFO - 'sessionrestore', 06:51:56 INFO - 'sessionrestore_no_auto_restore']}, 06:51:56 INFO - 'svgr': {'tests': ['tsvgx', 06:51:56 INFO - 'tsvgr_opacity', 06:51:56 INFO - 'tart', 06:51:56 INFO - 'tscrollx', 06:51:56 INFO - 'cart']}, 06:51:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['tsvgx', 06:51:56 INFO - 'tsvgr_opacity', 06:51:56 INFO - 'tart', 06:51:56 INFO - 'tscrollx', 06:51:56 INFO - 'cart']}, 06:51:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'tests': ['tp5o']}, 06:51:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'talos_options': ['--e10s'], 06:51:56 INFO - 'tests': ['tp5o']}, 06:51:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'talos_options': ['--xperf_path', 06:51:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:56 INFO - 'tests': ['tp5n']}, 06:51:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:51:56 INFO - 'talos_options': ['--e10s', 06:51:56 INFO - '--xperf_path', 06:51:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:51:56 INFO - 'tests': ['tp5n']}}, 06:51:56 INFO - 'talos.zip': {'path': '', 06:51:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:51:56 INFO - Running post-action listener: _resource_record_post_action 06:51:56 INFO - ##### 06:51:56 INFO - ##### Running create-virtualenv step. 06:51:56 INFO - ##### 06:51:56 INFO - Running pre-action listener: _resource_record_pre_action 06:51:56 INFO - Running main action method: create_virtualenv 06:51:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:51:56 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 06:51:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:51:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:51:56 INFO - Using real prefix '/usr' 06:51:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:51:57 INFO - Installing distribute.............................................................................................................................................................................................done. 06:51:59 INFO - Installing pip.................done. 06:51:59 INFO - Return code: 0 06:51:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:59 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:51:59 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 06:51:59 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 06:51:59 INFO - Using env: {'DISPLAY': ':0', 06:51:59 INFO - 'HOME': '/home/cltbld', 06:51:59 INFO - 'LANG': 'en_US.UTF-8', 06:51:59 INFO - 'LANGUAGE': 'en_US:en', 06:51:59 INFO - 'LOGNAME': 'cltbld', 06:51:59 INFO - 'MAIL': '/var/mail/cltbld', 06:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:59 INFO - 'MOZ_NO_REMOTE': '1', 06:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:59 INFO - 'NO_EM_RESTART': '1', 06:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:59 INFO - 'SHELL': '/bin/bash', 06:51:59 INFO - 'SHLVL': '1', 06:51:59 INFO - 'TERM': 'linux', 06:51:59 INFO - 'TMOUT': '86400', 06:51:59 INFO - 'USER': 'cltbld', 06:51:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:59 INFO - '_': '/tools/buildbot/bin/python'} 06:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:59 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 06:51:59 INFO - Cleaning up... 06:51:59 INFO - Return code: 0 06:51:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:51:59 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:51:59 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 06:51:59 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 06:51:59 INFO - Using env: {'DISPLAY': ':0', 06:51:59 INFO - 'HOME': '/home/cltbld', 06:51:59 INFO - 'LANG': 'en_US.UTF-8', 06:51:59 INFO - 'LANGUAGE': 'en_US:en', 06:51:59 INFO - 'LOGNAME': 'cltbld', 06:51:59 INFO - 'MAIL': '/var/mail/cltbld', 06:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:59 INFO - 'MOZ_NO_REMOTE': '1', 06:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:59 INFO - 'NO_EM_RESTART': '1', 06:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 06:51:59 INFO - 'SHELL': '/bin/bash', 06:51:59 INFO - 'SHLVL': '1', 06:51:59 INFO - 'TERM': 'linux', 06:51:59 INFO - 'TMOUT': '86400', 06:51:59 INFO - 'USER': 'cltbld', 06:51:59 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:59 INFO - '_': '/tools/buildbot/bin/python'} 06:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:51:59 INFO - Downloading/unpacking psutil>=0.7.1 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:51:59 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 06:52:01 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:01 INFO - Installing collected packages: psutil 06:52:01 INFO - Running setup.py install for psutil 06:52:01 INFO - building 'psutil._psutil_linux' extension 06:52:01 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 06:52:01 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 06:52:01 INFO - building 'psutil._psutil_posix' extension 06:52:01 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 06:52:01 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 06:52:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:01 INFO - Successfully installed psutil 06:52:01 INFO - Cleaning up... 06:52:02 INFO - Return code: 0 06:52:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:02 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52:02 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 06:52:02 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 06:52:02 INFO - Using env: {'DISPLAY': ':0', 06:52:02 INFO - 'HOME': '/home/cltbld', 06:52:02 INFO - 'LANG': 'en_US.UTF-8', 06:52:02 INFO - 'LANGUAGE': 'en_US:en', 06:52:02 INFO - 'LOGNAME': 'cltbld', 06:52:02 INFO - 'MAIL': '/var/mail/cltbld', 06:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:02 INFO - 'MOZ_NO_REMOTE': '1', 06:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:02 INFO - 'NO_EM_RESTART': '1', 06:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:02 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:02 INFO - 'SHELL': '/bin/bash', 06:52:02 INFO - 'SHLVL': '1', 06:52:02 INFO - 'TERM': 'linux', 06:52:02 INFO - 'TMOUT': '86400', 06:52:02 INFO - 'USER': 'cltbld', 06:52:02 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:02 INFO - '_': '/tools/buildbot/bin/python'} 06:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:52:04 INFO - Installing collected packages: mozsystemmonitor 06:52:04 INFO - Running setup.py install for mozsystemmonitor 06:52:04 INFO - Successfully installed mozsystemmonitor 06:52:04 INFO - Cleaning up... 06:52:04 INFO - Return code: 0 06:52:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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', '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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:52: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 blobuploader==1.2.4 06:52:04 INFO - Using env: {'DISPLAY': ':0', 06:52:04 INFO - 'HOME': '/home/cltbld', 06:52:04 INFO - 'LANG': 'en_US.UTF-8', 06:52:04 INFO - 'LANGUAGE': 'en_US:en', 06:52:04 INFO - 'LOGNAME': 'cltbld', 06:52:04 INFO - 'MAIL': '/var/mail/cltbld', 06:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:04 INFO - 'MOZ_NO_REMOTE': '1', 06:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:04 INFO - 'NO_EM_RESTART': '1', 06:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:04 INFO - 'SHELL': '/bin/bash', 06:52:04 INFO - 'SHLVL': '1', 06:52:04 INFO - 'TERM': 'linux', 06:52:04 INFO - 'TMOUT': '86400', 06:52:04 INFO - 'USER': 'cltbld', 06:52:04 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:04 INFO - '_': '/tools/buildbot/bin/python'} 06:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:06 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:52:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:52:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:52:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:06 INFO - Downloading docopt-0.6.1.tar.gz 06:52:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:52:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:06 INFO - Running setup.py install for blobuploader 06:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:52:06 INFO - Running setup.py install for requests 06:52:07 INFO - Running setup.py install for docopt 06:52:07 INFO - Successfully installed blobuploader requests docopt 06:52:07 INFO - Cleaning up... 06:52:07 INFO - Return code: 0 06:52:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:07 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52:07 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 06:52:07 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 06:52:07 INFO - Using env: {'DISPLAY': ':0', 06:52:07 INFO - 'HOME': '/home/cltbld', 06:52:07 INFO - 'LANG': 'en_US.UTF-8', 06:52:07 INFO - 'LANGUAGE': 'en_US:en', 06:52:07 INFO - 'LOGNAME': 'cltbld', 06:52:07 INFO - 'MAIL': '/var/mail/cltbld', 06:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:07 INFO - 'MOZ_NO_REMOTE': '1', 06:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:07 INFO - 'NO_EM_RESTART': '1', 06:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:07 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:07 INFO - 'SHELL': '/bin/bash', 06:52:07 INFO - 'SHLVL': '1', 06:52:07 INFO - 'TERM': 'linux', 06:52:07 INFO - 'TMOUT': '86400', 06:52:07 INFO - 'USER': 'cltbld', 06:52:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:07 INFO - '_': '/tools/buildbot/bin/python'} 06:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:07 INFO - Running setup.py (path:/tmp/pip-oipvZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:07 INFO - Running setup.py (path:/tmp/pip-mn4zcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:07 INFO - Running setup.py (path:/tmp/pip-JafZny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:07 INFO - Running setup.py (path:/tmp/pip-QXYoEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:07 INFO - Running setup.py (path:/tmp/pip-mTgVEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:07 INFO - Running setup.py (path:/tmp/pip-peSktQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:08 INFO - Running setup.py (path:/tmp/pip-Z4xWMl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:08 INFO - Running setup.py (path:/tmp/pip-JVRk1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:08 INFO - Running setup.py (path:/tmp/pip-6ZRXQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:08 INFO - Running setup.py (path:/tmp/pip-33duCj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:08 INFO - Running setup.py (path:/tmp/pip-0jUVSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:08 INFO - Running setup.py (path:/tmp/pip-Z54S6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:08 INFO - Running setup.py (path:/tmp/pip-ImpnfH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:08 INFO - Running setup.py (path:/tmp/pip-MEG0MS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:08 INFO - Running setup.py (path:/tmp/pip-TBdWRc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:08 INFO - Running setup.py (path:/tmp/pip-4e3myy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:08 INFO - Running setup.py (path:/tmp/pip-4eiwD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:08 INFO - Running setup.py install for manifestparser 06:52:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:52:08 INFO - Running setup.py install for mozcrash 06:52:09 INFO - Running setup.py install for mozdebug 06:52:09 INFO - Running setup.py install for mozdevice 06:52:09 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for mozfile 06:52:09 INFO - Running setup.py install for mozhttpd 06:52:09 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for mozinfo 06:52:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for mozInstall 06:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for mozleak 06:52:09 INFO - Running setup.py install for mozlog 06:52:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for moznetwork 06:52:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:52:09 INFO - Running setup.py install for mozprocess 06:52:10 INFO - Running setup.py install for mozprofile 06:52:10 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Running setup.py install for mozrunner 06:52:10 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Running setup.py install for mozscreenshot 06:52:10 INFO - Running setup.py install for moztest 06:52:10 INFO - Running setup.py install for mozversion 06:52:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:10 INFO - Cleaning up... 06:52:10 INFO - Return code: 0 06:52:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:10 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')]} 06:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:10 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')]} 06:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:10 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52:10 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 06:52:10 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 06:52:10 INFO - Using env: {'DISPLAY': ':0', 06:52:10 INFO - 'HOME': '/home/cltbld', 06:52:10 INFO - 'LANG': 'en_US.UTF-8', 06:52:10 INFO - 'LANGUAGE': 'en_US:en', 06:52:10 INFO - 'LOGNAME': 'cltbld', 06:52:10 INFO - 'MAIL': '/var/mail/cltbld', 06:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:10 INFO - 'MOZ_NO_REMOTE': '1', 06:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:10 INFO - 'NO_EM_RESTART': '1', 06:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:10 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:10 INFO - 'SHELL': '/bin/bash', 06:52:10 INFO - 'SHLVL': '1', 06:52:10 INFO - 'TERM': 'linux', 06:52:10 INFO - 'TMOUT': '86400', 06:52:10 INFO - 'USER': 'cltbld', 06:52:10 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:10 INFO - '_': '/tools/buildbot/bin/python'} 06:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:10 INFO - Running setup.py (path:/tmp/pip-85pNfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:52:10 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)) 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:10 INFO - Running setup.py (path:/tmp/pip-jhkRYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:52:10 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)) 06:52:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:10 INFO - Running setup.py (path:/tmp/pip-YED1OG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:11 INFO - Running setup.py (path:/tmp/pip-iBvpjj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:52:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:11 INFO - Running setup.py (path:/tmp/pip-k3ddkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:11 INFO - Running setup.py (path:/tmp/pip-S91X_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:11 INFO - Running setup.py (path:/tmp/pip-TwxXib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:11 INFO - Running setup.py (path:/tmp/pip-Ha2J0F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:11 INFO - Running setup.py (path:/tmp/pip-jAchaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:11 INFO - Running setup.py (path:/tmp/pip-n0w2qW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:11 INFO - Running setup.py (path:/tmp/pip-cQnoxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:11 INFO - Running setup.py (path:/tmp/pip-iAmnNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:11 INFO - Running setup.py (path:/tmp/pip-1lAzlc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:11 INFO - Running setup.py (path:/tmp/pip-QZY0ay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:11 INFO - Running setup.py (path:/tmp/pip-Zabc7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:11 INFO - Running setup.py (path:/tmp/pip-le1uoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:52:11 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)) 06:52:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:11 INFO - Running setup.py (path:/tmp/pip-G4sDG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:52:12 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)) 06:52:12 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)) 06:52:12 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)) 06:52:12 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)) 06:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:13 INFO - Downloading blessings-1.5.1.tar.gz 06:52:13 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 06:52:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:13 INFO - Installing collected packages: blessings 06:52:13 INFO - Running setup.py install for blessings 06:52:13 INFO - Successfully installed blessings 06:52:13 INFO - Cleaning up... 06:52:14 INFO - Return code: 0 06:52:14 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:52:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:14 INFO - Reading from file tmpfile_stdout 06:52:14 INFO - Current package versions: 06:52:14 INFO - argparse == 1.2.1 06:52:14 INFO - blessings == 1.5.1 06:52:14 INFO - blobuploader == 1.2.4 06:52:14 INFO - docopt == 0.6.1 06:52:14 INFO - manifestparser == 1.1 06:52:14 INFO - mozInstall == 1.12 06:52:14 INFO - mozcrash == 0.16 06:52:14 INFO - mozdebug == 0.1 06:52:14 INFO - mozdevice == 0.48 06:52:14 INFO - mozfile == 1.2 06:52:14 INFO - mozhttpd == 0.7 06:52:14 INFO - mozinfo == 0.9 06:52:14 INFO - mozleak == 0.1 06:52:14 INFO - mozlog == 3.1 06:52:14 INFO - moznetwork == 0.27 06:52:14 INFO - mozprocess == 0.22 06:52:14 INFO - mozprofile == 0.28 06:52:14 INFO - mozrunner == 6.11 06:52:14 INFO - mozscreenshot == 0.1 06:52:14 INFO - mozsystemmonitor == 0.0 06:52:14 INFO - moztest == 0.7 06:52:14 INFO - mozversion == 1.4 06:52:14 INFO - psutil == 3.1.1 06:52:14 INFO - requests == 1.2.3 06:52:14 INFO - wsgiref == 0.1.2 06:52:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:52:14 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')]} 06:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:14 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')]} 06:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:14 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52:14 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 06:52:14 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 06:52:14 INFO - Using env: {'DISPLAY': ':0', 06:52:14 INFO - 'HOME': '/home/cltbld', 06:52:14 INFO - 'LANG': 'en_US.UTF-8', 06:52:14 INFO - 'LANGUAGE': 'en_US:en', 06:52:14 INFO - 'LOGNAME': 'cltbld', 06:52:14 INFO - 'MAIL': '/var/mail/cltbld', 06:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:14 INFO - 'MOZ_NO_REMOTE': '1', 06:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:14 INFO - 'NO_EM_RESTART': '1', 06:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:14 INFO - 'SHELL': '/bin/bash', 06:52:14 INFO - 'SHLVL': '1', 06:52:14 INFO - 'TERM': 'linux', 06:52:14 INFO - 'TMOUT': '86400', 06:52:14 INFO - 'USER': 'cltbld', 06:52:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:14 INFO - '_': '/tools/buildbot/bin/python'} 06:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52:14 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)) 06:52: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:52:14 INFO - Cleaning up... 06:52:14 INFO - Return code: 0 06:52:14 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:52:14 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')]} 06:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:14 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')]} 06:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:14 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 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52:14 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 06:52:14 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 06:52:14 INFO - Using env: {'DISPLAY': ':0', 06:52:14 INFO - 'HOME': '/home/cltbld', 06:52:14 INFO - 'LANG': 'en_US.UTF-8', 06:52:14 INFO - 'LANGUAGE': 'en_US:en', 06:52:14 INFO - 'LOGNAME': 'cltbld', 06:52:14 INFO - 'MAIL': '/var/mail/cltbld', 06:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:14 INFO - 'MOZ_NO_REMOTE': '1', 06:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:14 INFO - 'NO_EM_RESTART': '1', 06:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:14 INFO - 'SHELL': '/bin/bash', 06:52:14 INFO - 'SHLVL': '1', 06:52:14 INFO - 'TERM': 'linux', 06:52:14 INFO - 'TMOUT': '86400', 06:52:14 INFO - 'USER': 'cltbld', 06:52:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:14 INFO - '_': '/tools/buildbot/bin/python'} 06:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:14 INFO - Downloading/unpacking jsonschema 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:16 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 06:52:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:52:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:52:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:52:16 INFO - warning: no files found matching '*.txt' 06:52:16 INFO - no previously-included directories found matching 'build' 06:52:16 INFO - no previously-included directories found matching 'dist' 06:52:16 INFO - no previously-included directories found matching '.git*' 06:52:16 INFO - Installing collected packages: jsonschema, functools32 06:52:16 INFO - Running setup.py install for functools32 06:52:16 INFO - warning: no files found matching '*.txt' 06:52:16 INFO - no previously-included directories found matching 'build' 06:52:16 INFO - no previously-included directories found matching 'dist' 06:52:16 INFO - no previously-included directories found matching '.git*' 06:52:16 INFO - Successfully installed jsonschema functools32 06:52:16 INFO - Cleaning up... 06:52:16 INFO - Return code: 0 06:52:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:52: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')]} 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8ac9baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ac0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, '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': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', '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 06:52: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', 'flake8'] in /builds/slave/test-pgo/build 06:52: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 flake8 06:52:16 INFO - Using env: {'DISPLAY': ':0', 06:52:16 INFO - 'HOME': '/home/cltbld', 06:52:16 INFO - 'LANG': 'en_US.UTF-8', 06:52:16 INFO - 'LANGUAGE': 'en_US:en', 06:52:16 INFO - 'LOGNAME': 'cltbld', 06:52:16 INFO - 'MAIL': '/var/mail/cltbld', 06:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:16 INFO - 'MOZ_NO_REMOTE': '1', 06:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:16 INFO - 'NO_EM_RESTART': '1', 06:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:16 INFO - 'SHELL': '/bin/bash', 06:52:16 INFO - 'SHLVL': '1', 06:52:16 INFO - 'TERM': 'linux', 06:52:16 INFO - 'TMOUT': '86400', 06:52:16 INFO - 'USER': 'cltbld', 06:52:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:16 INFO - '_': '/tools/buildbot/bin/python'} 06:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:17 INFO - Downloading/unpacking flake8 06:52:17 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 06:52:17 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 06:52:17 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 06:52:17 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 06:52:17 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 06:52:17 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 06:52:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:52:18 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 06:52:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:52:18 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 06:52:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:19 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 06:52:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:52:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:19 INFO - no previously-included directories found matching 'docs/_build' 06:52:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:52:19 INFO - Running setup.py install for pep8 06:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:52:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:52:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:52:19 INFO - no previously-included directories found matching 'docs/_build' 06:52:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:52:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:52:19 INFO - Cleaning up... 06:52:19 INFO - Return code: 0 06:52:19 INFO - Running post-action listener: _resource_record_post_action 06:52:19 INFO - Running post-action listener: _start_resource_monitoring 06:52:19 INFO - Starting resource monitoring. 06:52:19 INFO - ##### 06:52:19 INFO - ##### Running install step. 06:52:19 INFO - ##### 06:52:19 INFO - Running pre-action listener: _resource_record_pre_action 06:52:19 INFO - Running main action method: install 06:52:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:52:19 INFO - Reading from file tmpfile_stdout 06:52:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:52:19 INFO - Reading from file tmpfile_stdout 06:52:19 INFO - Output received: 06:52:19 INFO - Usage: mozinstall [options] installer 06:52:19 INFO - Options: 06:52:19 INFO - -h, --help show this help message and exit 06:52:19 INFO - -d DEST, --destination=DEST 06:52:19 INFO - Directory to install application into. [default: 06:52:19 INFO - "/builds/slave/test-pgo"] 06:52:19 INFO - --app=APP Application being installed. [default: firefox] 06:52:19 INFO - mkdir: /builds/slave/test-pgo/build/application 06:52:19 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'] 06:52:19 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 06:52:36 INFO - Reading from file tmpfile_stdout 06:52:36 INFO - Output received: 06:52:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:52:36 INFO - Running post-action listener: _resource_record_post_action 06:52:36 INFO - ##### 06:52:36 INFO - ##### Running run-tests step. 06:52:36 INFO - ##### 06:52:36 INFO - Running pre-action listener: _resource_record_pre_action 06:52:36 INFO - Running main action method: run_tests 06:52:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:52:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:52:36 INFO - Python 2.7.3 06:52:36 INFO - Return code: 0 06:52:36 INFO - grabbing minidump binary from tooltool 06:52:36 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')]} 06:52:36 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 0x2b51840>, '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 0x2abe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2abeb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:52:36 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 06:52:36 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 06:52:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:52:36 INFO - Return code: 0 06:52:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:52:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:52:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:52:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:52:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:52:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:52:37 INFO - Return code: 0 06:52:37 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/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 06:52:37 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/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 06:52:37 INFO - Using env: {'DISPLAY': ':0', 06:52:37 INFO - 'HOME': '/home/cltbld', 06:52:37 INFO - 'LANG': 'en_US.UTF-8', 06:52:37 INFO - 'LANGUAGE': 'en_US:en', 06:52:37 INFO - 'LOGNAME': 'cltbld', 06:52:37 INFO - 'MAIL': '/var/mail/cltbld', 06:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:37 INFO - 'MOZ_NO_REMOTE': '1', 06:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:52:37 INFO - 'NO_EM_RESTART': '1', 06:52:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:52:37 INFO - 'PWD': '/builds/slave/test-pgo', 06:52:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:52:37 INFO - 'SHELL': '/bin/bash', 06:52:37 INFO - 'SHLVL': '1', 06:52:37 INFO - 'TERM': 'linux', 06:52:37 INFO - 'TMOUT': '86400', 06:52:37 INFO - 'USER': 'cltbld', 06:52:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073', 06:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:37 INFO - '_': '/tools/buildbot/bin/python'} 06:52:37 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/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 06:52:37 INFO - mozversion application_buildid: 20160115043011 06:52:37 INFO - mozversion application_changeset: e1486d83107fc4933982d371828d038ad57682e4 06:52:37 INFO - mozversion application_display_name: Nightly 06:52:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:52:37 INFO - mozversion application_name: Firefox 06:52:37 INFO - mozversion application_remotingname: firefox 06:52:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:52:37 INFO - mozversion application_vendor: Mozilla 06:52:37 INFO - mozversion application_version: 46.0a1 06:52:37 INFO - mozversion platform_buildid: 20160115043011 06:52:37 INFO - mozversion platform_changeset: e1486d83107fc4933982d371828d038ad57682e4 06:52:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:52:37 INFO - mozversion platform_version: 46.0a1 06:52:37 INFO - using testdate: 1452869557 06:52:37 INFO - actual date: 1452869557 06:52:37 INFO - starting webserver on 'localhost:53974' 06:52:37 INFO - SUITE-START | Running 3 tests 06:52:37 INFO - TEST-START | dromaeo_css 06:52:37 INFO - operating with platform_type : linux_ 06:52:37 INFO - Initialising browser for dromaeo_css test... 06:52:37 INFO - TEST-INFO | started process 1294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhpxeL/profile http://localhost:53974/getInfo.html) 06:52:40 INFO - PROCESS | 1294 | __metrics Screen width/height:1600/1200 06:52:40 INFO - PROCESS | 1294 | colorDepth:24 06:52:40 INFO - PROCESS | 1294 | Browser inner width/height: 1024/697 06:52:40 INFO - PROCESS | 1294 | __metrics 06:52:40 INFO - PROCESS | 1294 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:52:41 INFO - PROCESS | 1294 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:52:42 INFO - TEST-INFO | 1294: exit 0 06:52:42 INFO - Browser initialized. 06:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 06:52:42 INFO - TEST-INFO | started process 1384 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhpxeL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:52:53 INFO - PROCESS | 1384 | RSS: Main: 150368256 06:52:53 INFO - PROCESS | 1384 | 06:53:45 INFO - PROCESS | 1384 | 1452869625236 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] 06:55:52 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53974/tests/dromaeo/cssquery-ext.html) 06:55:54 INFO - PROCESS | 1384 | RSS: Main: 302776320 06:55:54 INFO - PROCESS | 1384 | 06:58:56 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-ext.html (next: http://localhost:53974/tests/dromaeo/cssquery-jquery.html) 06:58:57 INFO - PROCESS | 1384 | RSS: Main: 236429312 06:58:57 INFO - PROCESS | 1384 | 07:01:59 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53974/tests/dromaeo/cssquery-mootools.html) 07:01:59 INFO - PROCESS | 1384 | RSS: Main: 232988672 07:01:59 INFO - PROCESS | 1384 | 07:05:01 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53974/tests/dromaeo/cssquery-prototype.html) 07:05:02 INFO - PROCESS | 1384 | RSS: Main: 213049344 07:05:02 INFO - PROCESS | 1384 | 07:08:05 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53974/tests/dromaeo/cssquery-yui.html) 07:08:05 INFO - PROCESS | 1384 | RSS: Main: 216268800 07:08:05 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | Cycle 1(1): loaded http://localhost:53974/tests/dromaeo/cssquery-yui.html (next: http://localhost:53974/tests/dromaeo/cssquery-dojo.html) 07:11:08 INFO - PROCESS | 1384 | RSS: Main: 291905536 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | __start_tp_report 07:11:08 INFO - PROCESS | 1384 | _x_x_mozilla_page_load 07:11:08 INFO - PROCESS | 1384 | _x_x_mozilla_page_load_details 07:11:08 INFO - PROCESS | 1384 | |i|pagename|runs| 07:11:08 INFO - PROCESS | 1384 | |0;dojo.html;3131.6398614159375;3150.212446888278;3191.473406887864;3196.2009497625595;3212.389645967266;5014.122528557497;5069.315642388272;5102.693838369701;5111.15665915124;5122.948770512294;5151.098557752397;5183.688978661283;5227.3465816772905;5229.764660590273;5239.423663397023;4503.234450143484;4691.835785747499;4709.717416954976;4740.502247264039;4878.512148785128;4770.809167633291;4796.208625576775;4822.156122678517;4842.128416884977;4846.4911184325665;4644.489106198315;4727.054589082198;4730.385049943519;4797.376341075673;4826.951730482685;4748.169070412699;4751.667383283171;4755.167845627036;4755.2153894607345;4788.233882578806;4731.101090792738;4737.905241895177;4740.3837501124635;4755.667103302771;4760.381150450419;4986.376702912136;5028.773705183239;5037.647364684473;5075.746212689388;5088;5534.75093620788;5569.136783798518;5573.832785016456;5581.190727344553;5589.664620122806;5327.227552004976;5618.747156377973;5619.971900140473;5623.690697011662;5628.915566266509;5133.922991155136;5265.76304066318;5266.420693723688;5287.550558202519;5337.2527846101575;5635.6618602883955;5636.436356364413;5651;5656.717164141776;5668.659880407106;5383;5465.890682186334;5469.288992430958;5469.781208751685;5471.37079235893;5599.496045355938;5616.550675945915;5619.634723742944;5620.960122377292;5639.492445679908;5506.531944784658;5558.610897237236;5563.99848027359;5569.470900264469;5570.275864137636;5390.245365648812;5465.262189604432;5536.307961504812;5566.35986861508;5607.130894711327;4333.848315308949;4342.478902531653;4350.9564904350555;4377.671674624416;4383.890402739893;3872.380419132925;3879.1465877506903;3881.7670939743707;3908.863189788344;3918.6081391860585;5126.410462796826;5205.609579281569;5211.400688920747;5221.660592061504;5306.946930530722;5576.832695019156;5583.692896890629;5606.747696353674;5610.803621873215;5611.102223644198;5207.895842083137;5219.660722053054;5225.555827754607;5225.843224703265;5271.42014378418;4707.576318131385;4780.808767649255;4797.616190704735;4810.39870016248;4866.367372241586;5682.77268909239;5682.914756278659;5687.232223649837;5697.601167918288;5710.571707121982;5461.781528738806;5488.91766623493;5494.1556826660035;5503.3395992481155;5544.500994910478;5642.322921249476;5643.548516118783;5792.21805056312;5834.38738932406;5843.678597677169;5435.184722291688;5452.727363631882;5455.781768729206;5457.454254574511;5459.781608735765;5427.077396842467;5522;5522.282103326542;5523.779048838162;5524.4199359066715;5413.53984911287;5436.565074793928;5438.83683489496;5441.29263195782;5444.6188766785945;5402.486763757437;5407.918881216706;5412.107002344569;5413.891722165614;5415.756290966995;5320.787168513216;5329.7068661224;5331.386890507486;5334.226537152169;5342.252084708066;5486.039943009878;5555.3611334697025;5564;5601.887962240651;5619.269494965792;5299.549538289289;5332.200169974535;5350.866228344323;5351.892962140658;5401.351837779492 07:11:08 INFO - PROCESS | 1384 | |1;ext.html;525.2488940814635;535.7642637239616;560.9130584759362;581.5492992930479;598.025218893204;28793.568096478542;36909.81545092274;37247.62752372479;37289.627103728955;37306.253874922484;39887;40358.19283614326;40377.19245615093;40514;40521.59478405215;8399.832003359945;8591.35564832637;8594;8601.483910965331;8603;8386.87419688705;8408.495490270572;8508.702195423162;8512.106228845974;8696.652133914637;8558.743237702878;8684.956575217115;8698.260647844942;8741.4755114693;8754.255888249507;8619.784505387384;8626.094260102724;8709.477431354107;8712.912870871336;8714.433561818525;8498.70254541088;8583.227509524111;8603.096674849114;8628.568571571397;8630.65477380904;39397.80301098505;39826;39840.800795996125;39862.60137398618;39890.40164397536;2903.172595810205;3193.2815116598813;3367.9494807577908;3425.4348032574844;3766.0773110587807;25923.611145832827;26149.869250653624;26192.8690356547;26293.342666433302;26748.06381776648;3614.0964758810296;3880.708946828999;3893.9415908761393;3937.625925537069;4044.8382064717375;218579;220205;220528;221150;221169;54726;55866.16200756992;56067;56127.15809262864;56165.43834561602;66335.33664663292;66923.33076669268;67206.66396667986;67233.98298050968;67272.66363668151;14235.217063061631;14398.20809855447;14418.206998615176;14424.423023079169;14434.422623095168;9840.704778856645;10031.849522257173;11209.831852522218;11284.774304513863;11325.150613704005;20009.899950500156;20193.495162621053;20231.86406107056;20304.898475507824;20404.693929591067;7760.758278675385;7970.851513652075;7986.281234688906;8015.318697910743;8020.639071241691;887.8756974023642;942.6229508196776;961.9807603847884;1036.9429681367596;1081.6754973508073;29342;29640.703592964226;31485.685143148734;33299.66700333014;33912;1010.2978429991233;1039.3919557059205;1095.5070218401593;1107.0147568663895;1137.8748337682848;15120.697586048438;15275.541733748005;15370.769438458432;15384.538463846102;15618;401051;402887;403154;409382;410484;55120;55223.17165242525;55599.444005559424;55627.72186139043;55666.16500752492;1332.3338330834583;1340.0217840975947;1349.3860293566404;1359.6261028217123;1361.4350044731325;28844.278893027844;29200.56199157057;29236.83052677869;29626.407471850875;29828.254293641963;47381.289280661505;48242.75878620584;48283.27575086306;48292.7585362071;48297.75851120722;303830;307748;307828;308078;308616;28211.43577128487;28728.13815585536;32130;32686.34627307488;33089.834550827094;37651.435228472146;38319.23361532698;38413.039674008374;38581.807090964365;38619.420708689955;32374.83812580922;33655.15862103369;34502.30995380028;35135.29729405347;35272.470912935816;29493.26266843346;34342.656573433946;34978.47532287068;35374.823125884206;35489.29021419609;32276.35447291088;33023.66976330206;33278;33287.33425331528;33525.329493410485;29053.273668158465;29623.451857771193;31220;32257.193570160933;32276;23668.763312366656;23845.761542385048;23848.642270366305;24007.63988540208;24302.635460467754 07:11:08 INFO - PROCESS | 1384 | |2;jquery.html;367.88043885737136;369.5270054330457;370.3944051475836;370.8368317940106;378.5419642232898;13685.726285474284;13731.931340343284;15425.15161666108;16406.589835254126;17120.74318885218;15260.771088433683;15579.53261402157;15595.376184952616;15690.450834220805;16549.089800060992;5201.297824793652;5385.030694474993;5387.542058924996;5387.946120538783;5390.91913621294;3945.9210815783667;4041.211963667086;5283.418823929364;5347.732613369335;5602.747876345574;5723.627964182336;5752.050911599581;5776.451237132465;5779.9422005779825;5781.277340332458;5080.923786143211;5245.318108645852;5263.131583288791;5266.210068489738;5266.499682530153;4923.261510773377;5047.798088076473;5095.541401273903;5095.668781529226;5096.362954630671;12477.875221247763;13058.412371443308;18094.819051809445;18696.532586685305;18734.1569629367;1932.2657390191778;1952.4435535872208;1977.5451646121473;2067.1421360135528;2117.788221177885;8720.345974051972;9113.407628504192;9239.861402078974;9247.12152345526;9289.953550232272;1707.538964479596;1714.13436214712;1772.7163653815328;1824.662437449063;1850.5928695687062;55838.44161558373;57028.144577831365;57087.42912570863;57115.428845711845;57575.71212143912;9729.805403891882;9770.267229957639;9827.754306142404;9863.605455781832;9992.850107248398;12686.80969785454;12709.237445753284;12728.745425091447;12751.872481275253;12763.553275635308;6906.861862762717;7191.496595238283;7202;7207.279272072751;7260.346568808833;6974.651267436608;6978.685959131852;7007.124109486314;7016.964915175391;7033.929660703429;4109.835606575763;4120.91758164835;4141.979290103591;4143.274926887782;4172.311568591209;1720.2946791815295;1743.1371471121622;1791.6105541423565;1849.7317888906034;1861.7300491428666;456.76248350857367;461.33106994857593;472.04882162442703;818.8157664525434;1002.478711070254;10133.240006999504;10374.118199952938;10392.168626509861;10444.791104177873;10586.947065264625;405.4222732606025;458.7591514454938;465.43217274924535;475.916714574948;489.33939182103876;5834.3290521589715;6021.7591296347655;6104.633721976696;6143.201383820164;6156.907646385308;537836;538061;549394;554188;554361;67557;72257.63871180611;74446;75054;75102.62448687722;1123.9550417983353;1148.9138314626437;1149.5631659969158;1155.3241353808116;1162.8837116288303;14423.639409014439;14477.348519316867;14651.82785377146;14872.405103795727;14911.776323355376;32047.35905281928;32756.181095472803;32768;33060.1734956628;33909.49135763015;43899;44924.77537612422;45123.323150152115;45921.31118033299;46379.30431043605;6902.240753517009;7174.641267936687;7178.712851485882;7222.89165662526;7278.017467641801;10358.223133265186;10767.300125491818;11061.170412219277;11094.500747466222;11695.12286578493;9177.678781242625;9475.289353298667;9811.313208075651;10122.79754404893;10218.1825453965;9132.726018219464;9228.169464747936;9286.489243091695;9512.714618561455;9738.513074346112;7707.845843082995;9489;9865.260105491972;9959.551820168255;10065.446400448045;7254.274572542704;7425.480216385017;7477.887831682638;7500.212477689982;7504.287092726182;8272.917270827455;9955.900440995498;10040.246981476272;10108.393496389946;10190.592376304865 07:11:08 INFO - PROCESS | 1384 | |3;mootools.html;1329.3884812986025;1506.2920427399122;1508.818941726993;1683.9326426942923;1825.297260554686;6508.772192973241;7461.060124367663;7562.924370756291;7580.507267027653;7580.734674286401;7456.440766942487;7629.9237007630045;7645.1590325064335;7647.694092236317;7654.770356889288;1973.4079776067194;2016.6168427998707;2019.5355068334218;2299.678045073687;2329.487512747193;2001.1595130045416;2290.3930458428445;2314.0396735354893;2321.558903808271;2326.2672258238686;2301.735300440454;2311.1217737259904;2311.43369874381;2312.6877871487304;2402.8077753779744;2235.2623634200677;2267.8299127565497;2280.09936075251;2282.3837563857833;2286.4283929017747;2283.315005498344;2283.5775381554467;2286.188403116903;2288.645259984705;2291.026313816638;7660.2722741339485;7711.190325015848;7767.495112817649;7767.766966990943;7771.961140194319;4808.855734327975;4885.145099607555;4904.190808516591;4911.729854857981;4914.140025495524;2963.2443726849733;3041.950527068158;3090.9381812363627;3126.6873312668777;3138.529220616903;946.7727745341138;970.2092794372634;992.0575453319375;992.5831150916632;1000.4447531619948;10520.105791007774;10531.210159238011;10564.894351056544;10590.152787777037;10635.787284254271;4372.1692878353015;4402.075564131568;4421.756803375781;4433.113377324548;4456.46522417312;9212.907870921204;9214.815703686023;9215.815683686289;9217.44695318283;9223.815523689489;4872.561469467765;4883.145449546315;4897.95102048975;4898.485659005824;4900.656954013185;4425.491068527161;4428.114377124588;4465.352523884018;4465.508794032654;4469.262571675637;3368.1579605098727;3429.3141371725756;3743.6335737455634;3836.731428800013;3851.441540976543;1209.60687776473;1209.6129238643725;1219.664592237142;1221.828943947848;1224.9265044097383;1037.190991027;1057.3655806516028;1057.836035414512;1181.1082632612322;1310.4823594680047;7086.2205157432645;7112.466565007645;7135.108111486064;7151.427885769126;7160.57036577807;1105.0993440346092;1121.9775604487866;1134.7163209197702;1135.4833550734395;1137.2607804926863;5762.769489220468;5854.473097421167;5860.853478663067;5861.472467477947;5865.970670146622;8821.911780882108;8831.779205519913;8971.955140224258;9006.774830629156;9057.230135438562;9033.50315732641;9053.094690530894;9097.363184577149;9100.271978241724;9103.089691030844;7020.543664661883;7150.499465037397;7218.278172182845;7220.494565380478;7284.235155308722;7231.963840180765;7312.890306645299;7320.963395183203;7337.3029562191505;7346.669399877125;8056.154103819014;8341.708040218564;8408.747737567883;8420.15798420153;8447.788805279917;8106.797330066795;8299.917000829915;8300.958495207486;8475;8482.61828217744;6741.932580674131;6935.479839012195;6940.444764418733;6954.652267386509;6956.2000369958105;6419.261784894797;6562.606243625398;7218.205997340393;7395.630218488946;7456.9254307458405;6970.79087627372;6992.440604751506;7109.0402795623995;7149.53528020677;7155.4633402496065;6808.761693340709;6943.027976083454;6944.270851560514;7022.859542809218;7066.646667666699;6947.895781563382;6980.965095174492;6984.26665200167;6989.986451964538;6991.265917078634;6362.300146983735;6439.967800160969;6449.290578036506;6459.741610335534;6529.379708927644;6435.22777266731;6449.516286278454;6477.125588045554;6478;6491.156149700509 07:11:08 INFO - PROCESS | 1384 | |4;prototype.html;335.9177001634599;344.94998225257336;347.8173958671697;352.3850880214027;357.4745124666739;5743.425657434254;5761.971190144049;5762;5788.305403351598;5905.940940590593;5665.943340566593;5823.767049318033;5826.999999999989;5856.2094117294155;5857.8828423431505;4521.8417355392485;4533.682642215046;4534.161180181661;4534.523874993128;4538.205813982539;4325.9351109733225;4397.296432570789;4418.2709852874395;4512.571305725951;4530.048689775152;4442.800443880151;4461.442319710036;4462.0183559616835;4462.910741785162;4473.463184417875;4454.198244316021;4464.575865292792;4468;4468.731876087412;4470.061287129706;3903.1608204236227;3907.6678482329035;3908.355121404965;3911.647951684362;3911.863084792047;5437.211604317352;5587.497125258747;5595.524380427669;5609.663420194802;5623.100303951348;5209.296744939423;5213.713245771481;5215.6349055566125;5215.947840521584;5217.217417387385;5905.232319798399;6215.7513699451965;6218.284897236786;6220.098085777582;6225.564210505267;4263.083437061046;4264.381664658638;4331.090471001062;4364.781760911974;4373.562643735633;6351;6495.285518592951;6527.804165875032;6540.182477190351;6541.47668186544;4436.134953684001;4437;4438.667099967515;4440.156370289635;4450.777461126995;4408.404865343202;4412.867613971586;4494.16857881293;4495.43807024122;4515.367848501212;5179.766910489037;5183.714895680774;5183.974080129575;5189.273501709764;5193.324867767242;6233.470155036873;6238.095476155932;6238.469730072904;6242.531810114259;6243.656598887105;1559.4463965292384;1580.5100418870188;1583.9683206335808;1584.3900098462175;1586.8730501559849;1066.1044722433194;1066.1950227578284;1068.2468859454066;1075.198976762317;1097.1716354152563;5855.414458554111;5861.648301101947;5867.413258674099;5904.439078287556;5912;6401.03984402334;6426.453751431087;6438.452731517874;6440.645764482999;6459.903101453482;5906.379830117861;5915.1718759373725;5917.704114794243;5919.733611987471;5920.79277225295;3393.3891899458336;3487.4943133246043;3492.4237500812587;3493.4235851084795;3494.4583589543663;6737.258901520829;6737.831554211086;6755.020522024279;6758.290379510081;6758.560693554903;6673.699683514254;6673.9332606673315;6675.766348177791;6680.03139544773;6687.364700353459;6557;6717.563358381787;6732.899006514906;6741.561798483083;6744.325567443217;6228.532860035606;6395.360463953567;6499.707513162014;6511.9348806511325;6520.087187793808;6262.405071518198;6383.457406120532;6405.135306733531;6409.7115629795835;6413.775517856852;6707.496937729592;6711.563748356341;6713.160854893138;6715.328467153246;6723.4957378197805;4319.784010799511;4421.579949904753;4464.977675111603;4468.932966005447;4471.754053527087;6368.044793281045;6388.840278993062;6389.265234497906;6408.455281301141;6445.1943507061615;6292.056191571301;6297.811065668037;6298.779542715983;6299.779507717208;6301.684915754102;6183.752649893954;6194.4115309045565;6270.655113968775;6277.686115694289;6290.0879372491645;6156.6921653918025;6164;6167.876642467215;6170.444659980623;6180.721867516063;6283.874322513433;6288.056791481315;6298.779542715983;6300.086487459201;6314.463270622048;6062.969685151546;6143.078538219124;6153.876922461615;6161.168242287413;6171.228596425447 07:11:08 INFO - PROCESS | 1384 | |5;yui.html;760.4638729695565;782.8629989751796;826.1160558202722;850.3239924260213;861.9698310559131;12830.679233019167;13008.544700935468;13102.475900963962;13131.474741010348;13132.146410483312;12489.68775780606;13039.543615973444;13042.413091410886;13053.543125990593;13061.085723999324;660.1088530483856;663.4360793325683;791.2325044706654;810.1493431896486;825.1500954017372;807.2774866494484;818.7625588579334;820.6184124382161;822.2887202569764;823.4318320358963;694.3958755882389;850.2517784349764;852.4629483425464;853.9231469167773;854.1287886355914;685.9245482996866;841.64915310926;856.567433446112;857.8455877941968;857.9828403431927;628.1770880147022;628.3841835001724;628.5600079944012;629.0469938043867;629.26061877294;10776.67669969902;10821.513031913582;10836.945815270874;10864.239503234776;10901.182411319103;11785.941070294593;11950.163488555805;12077.214981026205;12259.241670624127;12799;9775.853362199572;9823.115919567274;9899.208063354914;10029.949850250701;10040.347377420445;3474.2530355973586;3493.8427770750122;3572.517710109128;3574.803385813779;3589.910252243689;46056.53943460556;46101.53898461039;46315.30527042097;46367.53632463666;46517.30224046642;9677.000908029593;9887.555060022316;9903.851442228228;10144.644937427154;10431.269811113149;18079.186436610384;18671.066446677884;18684.34604788826;18752;18799;7436.814079648052;7472.065991751031;7500.062492188476;7518.774436766906;7573.772786816405;3948.861789837342;3998.7400818946676;4031.879043628696;4091.3453847384276;4117.197146556453;2982.731554160136;2994.1915682765966;3003.039027511219;3005.3087789808465;3005.443992861328;566.9121286200645;578.3522454850511;585.5257241634205;597.5876645114856;599.2748773983528;540.572947371572;556.6910364747523;655.7278729327371;661.0777964739162;699.7461802617868;8465.534395608302;8503.582049538067;8508.702195423131;8616.267617252604;8659.567021648892;519.2159838643676;546.0635010956229;581.813819577731;596.9323213156251;619.4239357397663;3906.121122747416;3952.9011774705286;3970.8808735737975;4034.374671925856;4130.256553820281;56981.43018569844;57387.426125739046;57479.712601436724;57656;57667.423325766205;47725.522744772104;47971.280430793566;48669.51330486721;48734.75632621814;49729.25406118911;44066.779666101465;44761;45034.77482612566;45714.31428528508;45945.31082033772;8053.798655033671;8061.677532898853;8834.514101724468;8895.2883769297;8994.370394072352;33959.92790417823;34519.82740086384;34572.654273456945;35347.293054139285;35389.64610353864;40607.1878562433;40682;43391.34912976245;45169.54830451653;45810;10064.29549931527;10196.286259961731;10594.523246454082;10755.838662420227;10768.138548915911;11570.305781653127;11641.6507504775;11929.701757456132;11973.221740586834;12370.381480926098;10282.691519254435;10644.308119972176;10840.186985975926;10857.945710271399;11270.088025902864;11411.60059397917;11474.483648235682;11514.481848316678;11611.825822612498;11872.881271187178;9682.951585242028;9953.353032052893;10058.698239052841;10152.949235253776;10290.948545257525;8504.872426913726;8702.216800487986;8846.98259700117;8886.289096872364;9017.09829017093;9146.176844084064;9442.81114377695;9519;9781.902180978099;9850.98430102168 07:11:08 INFO - PROCESS | 1384 | __end_tp_report 07:11:08 INFO - PROCESS | 1384 | __start_cc_report 07:11:08 INFO - PROCESS | 1384 | _x_x_mozilla_cycle_collect,1425 07:11:08 INFO - PROCESS | 1384 | __end_cc_report 07:11:08 INFO - PROCESS | 1384 | __startTimestamp1452870668439__endTimestamp 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | ------- Summary: start ------- 07:11:08 INFO - PROCESS | 1384 | Number of tests: 6 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#0] dojo.html Cycles:165 Average:5167.64 Median:5342.25 stddev:549.87 (10.3%) stddev-sans-first:527.84 07:11:08 INFO - PROCESS | 1384 | Values: 3131.6 3150.2 3191.5 3196.2 3212.4 5014.1 5069.3 5102.7 5111.2 5122.9 5151.1 5183.7 5227.3 5229.8 5239.4 4503.2 4691.8 4709.7 4740.5 4878.5 4770.8 4796.2 4822.2 4842.1 4846.5 4644.5 4727.1 4730.4 4797.4 4827.0 4748.2 4751.7 4755.2 4755.2 4788.2 4731.1 4737.9 4740.4 4755.7 4760.4 4986.4 5028.8 5037.6 5075.7 5088.0 5534.8 5569.1 5573.8 5581.2 5589.7 5327.2 5618.7 5620.0 5623.7 5628.9 5133.9 5265.8 5266.4 5287.6 5337.3 5635.7 5636.4 5651.0 5656.7 5668.7 5383.0 5465.9 5469.3 5469.8 5471.4 5599.5 5616.6 5619.6 5621.0 5639.5 5506.5 5558.6 5564.0 5569.5 5570.3 5390.2 5465.3 5536.3 5566.4 5607.1 4333.8 4342.5 4351.0 4377.7 4383.9 3872.4 3879.1 3881.8 3908.9 3918.6 5126.4 5205.6 5211.4 5221.7 5306.9 5576.8 5583.7 5606.7 5610.8 5611.1 5207.9 5219.7 5225.6 5225.8 5271.4 4707.6 4780.8 4797.6 4810.4 4866.4 5682.8 5682.9 5687.2 5697.6 5710.6 5461.8 5488.9 5494.2 5503.3 5544.5 5642.3 5643.5 5792.2 5834.4 5843.7 5435.2 5452.7 5455.8 5457.5 5459.8 5427.1 5522.0 5522.3 5523.8 5524.4 5413.5 5436.6 5438.8 5441.3 5444.6 5402.5 5407.9 5412.1 5413.9 5415.8 5320.8 5329.7 5331.4 5334.2 5342.3 5486.0 5555.4 5564.0 5601.9 5619.3 5299.5 5332.2 5350.9 5351.9 5401.4 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#1] ext.html Cycles:180 Average:47504.71 Median:19551.69 stddev:84377.20 (431.6%) stddev-sans-first:84540.17 07:11:08 INFO - PROCESS | 1384 | Values: 525.2 535.8 560.9 581.5 598.0 28793.6 36909.8 37247.6 37289.6 37306.3 39887.0 40358.2 40377.2 40514.0 40521.6 8399.8 8591.4 8594.0 8601.5 8603.0 8386.9 8408.5 8508.7 8512.1 8696.7 8558.7 8685.0 8698.3 8741.5 8754.3 8619.8 8626.1 8709.5 8712.9 8714.4 8498.7 8583.2 8603.1 8628.6 8630.7 39397.8 39826.0 39840.8 39862.6 39890.4 2903.2 3193.3 3367.9 3425.4 3766.1 25923.6 26149.9 26192.9 26293.3 26748.1 3614.1 3880.7 3893.9 3937.6 4044.8 218579.0 220205.0 220528.0 221150.0 221169.0 54726.0 55866.2 56067.0 56127.2 56165.4 66335.3 66923.3 67206.7 67234.0 67272.7 14235.2 14398.2 14418.2 14424.4 14434.4 9840.7 10031.8 11209.8 11284.8 11325.2 20009.9 20193.5 20231.9 20304.9 20404.7 7760.8 7970.9 7986.3 8015.3 8020.6 887.9 942.6 962.0 1036.9 1081.7 29342.0 29640.7 31485.7 33299.7 33912.0 1010.3 1039.4 1095.5 1107.0 1137.9 15120.7 15275.5 15370.8 15384.5 15618.0 401051.0 402887.0 403154.0 409382.0 410484.0 55120.0 55223.2 55599.4 55627.7 55666.2 1332.3 1340.0 1349.4 1359.6 1361.4 28844.3 29200.6 29236.8 29626.4 29828.3 47381.3 48242.8 48283.3 48292.8 48297.8 303830.0 307748.0 307828.0 308078.0 308616.0 28211.4 28728.1 32130.0 32686.3 33089.8 37651.4 38319.2 38413.0 38581.8 38619.4 32374.8 33655.2 34502.3 35135.3 35272.5 29493.3 34342.7 34978.5 35374.8 35489.3 32276.4 33023.7 33278.0 33287.3 33525.3 29053.3 29623.5 31220.0 32257.2 32276.0 23668.8 23845.8 23848.6 24007.6 24302.6 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#2] jquery.html Cycles:180 Average:27259.11 Median:482.63 stddev:89422.81 (18528.3%) stddev-sans-first:89650.87 07:11:08 INFO - PROCESS | 1384 | Values: 367.9 369.5 370.4 370.8 378.5 13685.7 13731.9 15425.2 16406.6 17120.7 15260.8 15579.5 15595.4 15690.5 16549.1 5201.3 5385.0 5387.5 5387.9 5390.9 3945.9 4041.2 5283.4 5347.7 5602.7 5723.6 5752.1 5776.5 5779.9 5781.3 5080.9 5245.3 5263.1 5266.2 5266.5 4923.3 5047.8 5095.5 5095.7 5096.4 12477.9 13058.4 18094.8 18696.5 18734.2 1932.3 1952.4 1977.5 2067.1 2117.8 8720.3 9113.4 9239.9 9247.1 9290.0 1707.5 1714.1 1772.7 1824.7 1850.6 55838.4 57028.1 57087.4 57115.4 57575.7 9729.8 9770.3 9827.8 9863.6 9992.9 12686.8 12709.2 12728.7 12751.9 12763.6 6906.9 7191.5 7202.0 7207.3 7260.3 6974.7 6978.7 7007.1 7017.0 7033.9 4109.8 4120.9 4142.0 4143.3 4172.3 1720.3 1743.1 1791.6 1849.7 1861.7 456.8 461.3 472.0 818.8 1002.5 10133.2 10374.1 10392.2 10444.8 10586.9 405.4 458.8 465.4 475.9 489.3 5834.3 6021.8 6104.6 6143.2 6156.9 537836.0 538061.0 549394.0 554188.0 554361.0 67557.0 72257.6 74446.0 75054.0 75102.6 1124.0 1148.9 1149.6 1155.3 1162.9 14423.6 14477.3 14651.8 14872.4 14911.8 32047.4 32756.2 32768.0 33060.2 33909.5 43899.0 44924.8 45123.3 45921.3 46379.3 6902.2 7174.6 7178.7 7222.9 7278.0 10358.2 10767.3 11061.2 11094.5 11695.1 9177.7 9475.3 9811.3 10122.8 10218.2 9132.7 9228.2 9286.5 9512.7 9738.5 7707.8 9489.0 9865.3 9959.6 10065.4 7254.3 7425.5 7477.9 7500.2 7504.3 8272.9 9955.9 10040.2 10108.4 10190.6 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#3] mootools.html Cycles:180 Average:5419.44 Median:6449.40 stddev:2759.69 (42.8%) stddev-sans-first:2750.31 07:11:08 INFO - PROCESS | 1384 | Values: 1329.4 1506.3 1508.8 1683.9 1825.3 6508.8 7461.1 7562.9 7580.5 7580.7 7456.4 7629.9 7645.2 7647.7 7654.8 1973.4 2016.6 2019.5 2299.7 2329.5 2001.2 2290.4 2314.0 2321.6 2326.3 2301.7 2311.1 2311.4 2312.7 2402.8 2235.3 2267.8 2280.1 2282.4 2286.4 2283.3 2283.6 2286.2 2288.6 2291.0 7660.3 7711.2 7767.5 7767.8 7772.0 4808.9 4885.1 4904.2 4911.7 4914.1 2963.2 3042.0 3090.9 3126.7 3138.5 946.8 970.2 992.1 992.6 1000.4 10520.1 10531.2 10564.9 10590.2 10635.8 4372.2 4402.1 4421.8 4433.1 4456.5 9212.9 9214.8 9215.8 9217.4 9223.8 4872.6 4883.1 4898.0 4898.5 4900.7 4425.5 4428.1 4465.4 4465.5 4469.3 3368.2 3429.3 3743.6 3836.7 3851.4 1209.6 1209.6 1219.7 1221.8 1224.9 1037.2 1057.4 1057.8 1181.1 1310.5 7086.2 7112.5 7135.1 7151.4 7160.6 1105.1 1122.0 1134.7 1135.5 1137.3 5762.8 5854.5 5860.9 5861.5 5866.0 8821.9 8831.8 8972.0 9006.8 9057.2 9033.5 9053.1 9097.4 9100.3 9103.1 7020.5 7150.5 7218.3 7220.5 7284.2 7232.0 7312.9 7321.0 7337.3 7346.7 8056.2 8341.7 8408.7 8420.2 8447.8 8106.8 8299.9 8301.0 8475.0 8482.6 6741.9 6935.5 6940.4 6954.7 6956.2 6419.3 6562.6 7218.2 7395.6 7456.9 6970.8 6992.4 7109.0 7149.5 7155.5 6808.8 6943.0 6944.3 7022.9 7066.6 6947.9 6981.0 6984.3 6990.0 6991.3 6362.3 6440.0 6449.3 6459.7 6529.4 6435.2 6449.5 6477.1 6478.0 6491.2 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#4] prototype.html Cycles:180 Average:5216.92 Median:5864.53 stddev:1574.81 (26.9%) stddev-sans-first:1536.03 07:11:08 INFO - PROCESS | 1384 | Values: 335.9 344.9 347.8 352.4 357.5 5743.4 5762.0 5762.0 5788.3 5905.9 5665.9 5823.8 5827.0 5856.2 5857.9 4521.8 4533.7 4534.2 4534.5 4538.2 4325.9 4397.3 4418.3 4512.6 4530.0 4442.8 4461.4 4462.0 4462.9 4473.5 4454.2 4464.6 4468.0 4468.7 4470.1 3903.2 3907.7 3908.4 3911.6 3911.9 5437.2 5587.5 5595.5 5609.7 5623.1 5209.3 5213.7 5215.6 5215.9 5217.2 5905.2 6215.8 6218.3 6220.1 6225.6 4263.1 4264.4 4331.1 4364.8 4373.6 6351.0 6495.3 6527.8 6540.2 6541.5 4436.1 4437.0 4438.7 4440.2 4450.8 4408.4 4412.9 4494.2 4495.4 4515.4 5179.8 5183.7 5184.0 5189.3 5193.3 6233.5 6238.1 6238.5 6242.5 6243.7 1559.4 1580.5 1584.0 1584.4 1586.9 1066.1 1066.2 1068.2 1075.2 1097.2 5855.4 5861.6 5867.4 5904.4 5912.0 6401.0 6426.5 6438.5 6440.6 6459.9 5906.4 5915.2 5917.7 5919.7 5920.8 3393.4 3487.5 3492.4 3493.4 3494.5 6737.3 6737.8 6755.0 6758.3 6758.6 6673.7 6673.9 6675.8 6680.0 6687.4 6557.0 6717.6 6732.9 6741.6 6744.3 6228.5 6395.4 6499.7 6511.9 6520.1 6262.4 6383.5 6405.1 6409.7 6413.8 6707.5 6711.6 6713.2 6715.3 6723.5 4319.8 4421.6 4465.0 4468.9 4471.8 6368.0 6388.8 6389.3 6408.5 6445.2 6292.1 6297.8 6298.8 6299.8 6301.7 6183.8 6194.4 6270.7 6277.7 6290.1 6156.7 6164.0 6167.9 6170.4 6180.7 6283.9 6288.1 6298.8 6300.1 6314.5 6063.0 6143.1 6153.9 6161.2 6171.2 07:11:08 INFO - PROCESS | 1384 | 07:11:08 INFO - PROCESS | 1384 | [#5] yui.html Cycles:180 Average:13375.15 Median:46442.42 stddev:15541.87 (33.5%) stddev-sans-first:15556.59 07:11:08 INFO - PROCESS | 1384 | Values: 760.5 782.9 826.1 850.3 862.0 12830.7 13008.5 13102.5 13131.5 13132.1 12489.7 13039.5 13042.4 13053.5 13061.1 660.1 663.4 791.2 810.1 825.2 807.3 818.8 820.6 822.3 823.4 694.4 850.3 852.5 853.9 854.1 685.9 841.6 856.6 857.8 858.0 628.2 628.4 628.6 629.0 629.3 10776.7 10821.5 10836.9 10864.2 10901.2 11785.9 11950.2 12077.2 12259.2 12799.0 9775.9 9823.1 9899.2 10029.9 10040.3 3474.3 3493.8 3572.5 3574.8 3589.9 46056.5 46101.5 46315.3 46367.5 46517.3 9677.0 9887.6 9903.9 10144.6 10431.3 18079.2 18671.1 18684.3 18752.0 18799.0 7436.8 7472.1 7500.1 7518.8 7573.8 3948.9 3998.7 4031.9 4091.3 4117.2 2982.7 2994.2 3003.0 3005.3 3005.4 566.9 578.4 585.5 597.6 599.3 540.6 556.7 655.7 661.1 699.7 8465.5 8503.6 8508.7 8616.3 8659.6 519.2 546.1 581.8 596.9 619.4 3906.1 3952.9 3970.9 4034.4 4130.3 56981.4 57387.4 57479.7 57656.0 57667.4 47725.5 47971.3 48669.5 48734.8 49729.3 44066.8 44761.0 45034.8 45714.3 45945.3 8053.8 8061.7 8834.5 8895.3 8994.4 33959.9 34519.8 34572.7 35347.3 35389.6 40607.2 40682.0 43391.3 45169.5 45810.0 10064.3 10196.3 10594.5 10755.8 10768.1 11570.3 11641.7 11929.7 11973.2 12370.4 10282.7 10644.3 10840.2 10857.9 11270.1 11411.6 11474.5 11514.5 11611.8 11872.9 9683.0 9953.4 10058.7 10152.9 10290.9 8504.9 8702.2 8847.0 8886.3 9017.1 9146.2 9442.8 9519.0 9781.9 9851.0 07:11:08 INFO - PROCESS | 1384 | -------- Summary: end -------- 07:11:08 INFO - PROCESS | 1384 | 07:11:09 INFO - TEST-INFO | 1384: exit 0 07:11:09 INFO - TEST-OK | dromaeo_css | took 1111845ms 07:11:09 INFO - TEST-START | kraken 07:11:09 INFO - operating with platform_type : linux_ 07:11:09 INFO - Initialising browser for kraken test... 07:11:09 INFO - TEST-INFO | started process 1588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3NHEoa/profile http://localhost:53974/getInfo.html) 07:11:12 INFO - PROCESS | 1588 | __metrics Screen width/height:1600/1200 07:11:12 INFO - PROCESS | 1588 | colorDepth:24 07:11:12 INFO - PROCESS | 1588 | Browser inner width/height: 1024/697 07:11:12 INFO - PROCESS | 1588 | __metrics 07:11:12 INFO - PROCESS | 1588 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:11:12 INFO - PROCESS | 1588 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:13 INFO - TEST-INFO | 1588: exit 0 07:11:13 INFO - Browser initialized. 07:11:13 INFO - Running cycle 1/1 for kraken test... 07:11:13 INFO - TEST-INFO | started process 1670 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3NHEoa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:25 INFO - PROCESS | 1670 | RSS: Main: 148807680 07:11:25 INFO - PROCESS | 1670 | 07:11:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53974/tests/kraken/driver.html?testName=audio-beat-detection) 07:11:28 INFO - PROCESS | 1670 | RSS: Main: 188030976 07:11:28 INFO - PROCESS | 1670 | 07:11:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53974/tests/kraken/driver.html?testName=audio-dft) 07:11:32 INFO - PROCESS | 1670 | RSS: Main: 176869376 07:11:32 INFO - PROCESS | 1670 | 07:11:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53974/tests/kraken/driver.html?testName=audio-fft) 07:11:35 INFO - PROCESS | 1670 | RSS: Main: 162590720 07:11:35 INFO - PROCESS | 1670 | 07:11:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53974/tests/kraken/driver.html?testName=audio-oscillator) 07:11:38 INFO - PROCESS | 1670 | RSS: Main: 163672064 07:11:38 INFO - PROCESS | 1670 | 07:11:40 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:11:40 INFO - PROCESS | 1670 | RSS: Main: 165523456 07:11:40 INFO - PROCESS | 1670 | 07:11:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53974/tests/kraken/driver.html?testName=imaging-darkroom) 07:11:44 INFO - PROCESS | 1670 | RSS: Main: 166707200 07:11:44 INFO - PROCESS | 1670 | 07:11:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53974/tests/kraken/driver.html?testName=imaging-desaturate) 07:11:48 INFO - PROCESS | 1670 | RSS: Main: 165175296 07:11:48 INFO - PROCESS | 1670 | 07:11:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53974/tests/kraken/driver.html?testName=json-parse-financial) 07:11:51 INFO - PROCESS | 1670 | RSS: Main: 165306368 07:11:51 INFO - PROCESS | 1670 | 07:11:53 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:11:53 INFO - PROCESS | 1670 | RSS: Main: 174489600 07:11:53 INFO - PROCESS | 1670 | 07:11:55 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:11:56 INFO - PROCESS | 1670 | RSS: Main: 174620672 07:11:56 INFO - PROCESS | 1670 | 07:11:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:11:58 INFO - PROCESS | 1670 | RSS: Main: 180699136 07:11:58 INFO - PROCESS | 1670 | 07:12:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:01 INFO - PROCESS | 1670 | RSS: Main: 189116416 07:12:01 INFO - PROCESS | 1670 | 07:12:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:04 INFO - PROCESS | 1670 | RSS: Main: 188469248 07:12:04 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:53974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53974/tests/kraken/driver.html?testName=ai-astar) 07:12:06 INFO - PROCESS | 1670 | RSS: Main: 245448704 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | __start_tp_report 07:12:06 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 07:12:06 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 07:12:06 INFO - PROCESS | 1670 | |i|pagename|runs| 07:12:06 INFO - PROCESS | 1670 | |0;ai-astar;109;109;105;108;110;109;99;109;110;111 07:12:06 INFO - PROCESS | 1670 | |1;audio-beat-detection;156;129;147;168;129;151;161;127;178;125 07:12:06 INFO - PROCESS | 1670 | |2;audio-dft;162;161;160;161;160;160;160;163;160;160 07:12:06 INFO - PROCESS | 1670 | |3;audio-fft;72;71;99;100;72;70;74;113;93;70 07:12:06 INFO - PROCESS | 1670 | |4;audio-oscillator;96;95;141;95;96;96;144;95;97;140 07:12:06 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;109;109;109;109;109;108;110;108;109;108 07:12:06 INFO - PROCESS | 1670 | |6;imaging-darkroom;145;145;145;145;145;146;146;146;145;145 07:12:06 INFO - PROCESS | 1670 | |7;imaging-desaturate;95;96;95;97;96;96;101;95;96;96 07:12:06 INFO - PROCESS | 1670 | |8;json-parse-financial;56;55;54;55;53;55;61;63;53;54 07:12:06 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;66;68;67;68;68;67;67;67;67;67 07:12:06 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;94;84;92;82;81;81;83;82;82;81 07:12:06 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;118;122;117;123;112;123;113;112;115;123 07:12:06 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;142;134;144;145;148;143;143;147;145;144 07:12:06 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;68;67;66;66;69;66;65;68;69;65 07:12:06 INFO - PROCESS | 1670 | __end_tp_report 07:12:06 INFO - PROCESS | 1670 | __start_cc_report 07:12:06 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,934 07:12:06 INFO - PROCESS | 1670 | __end_cc_report 07:12:06 INFO - PROCESS | 1670 | __startTimestamp1452870726796__endTimestamp 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | ------- Summary: start ------- 07:12:06 INFO - PROCESS | 1670 | Number of tests: 14 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.50 stddev:3.51 (3.2%) stddev-sans-first:3.70 07:12:06 INFO - PROCESS | 1670 | Values: 109.0 109.0 105.0 108.0 110.0 109.0 99.0 109.0 110.0 111.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:153.50 stddev:18.94 (12.3%) stddev-sans-first:19.81 07:12:06 INFO - PROCESS | 1670 | Values: 156.0 129.0 147.0 168.0 129.0 151.0 161.0 127.0 178.0 125.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.06 (0.7%) stddev-sans-first:1.01 07:12:06 INFO - PROCESS | 1670 | Values: 162.0 161.0 160.0 161.0 160.0 160.0 160.0 163.0 160.0 160.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:83.40 Median:72.00 stddev:16.15 (22.4%) stddev-sans-first:16.60 07:12:06 INFO - PROCESS | 1670 | Values: 72.0 71.0 99.0 100.0 72.0 70.0 74.0 113.0 93.0 70.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.50 stddev:22.23 (23.3%) stddev-sans-first:23.03 07:12:06 INFO - PROCESS | 1670 | Values: 96.0 95.0 141.0 95.0 96.0 96.0 144.0 95.0 97.0 140.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:12:06 INFO - PROCESS | 1670 | Values: 109.0 109.0 109.0 109.0 109.0 108.0 110.0 108.0 109.0 108.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:12:06 INFO - PROCESS | 1670 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 145.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.77 (1.8%) stddev-sans-first:1.81 07:12:06 INFO - PROCESS | 1670 | Values: 95.0 96.0 95.0 97.0 96.0 96.0 101.0 95.0 96.0 96.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:3.38 (6.1%) stddev-sans-first:3.59 07:12:06 INFO - PROCESS | 1670 | Values: 56.0 55.0 54.0 55.0 53.0 55.0 61.0 63.0 53.0 54.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 07:12:06 INFO - PROCESS | 1670 | Values: 66.0 68.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.50 stddev:4.76 (5.8%) stddev-sans-first:3.48 07:12:06 INFO - PROCESS | 1670 | Values: 94.0 84.0 92.0 82.0 81.0 81.0 83.0 82.0 82.0 81.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:120.00 stddev:4.69 (3.9%) stddev-sans-first:4.97 07:12:06 INFO - PROCESS | 1670 | Values: 118.0 122.0 117.0 123.0 112.0 123.0 113.0 112.0 115.0 123.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:144.50 stddev:3.81 (2.6%) stddev-sans-first:4.00 07:12:06 INFO - PROCESS | 1670 | Values: 142.0 134.0 144.0 145.0 148.0 143.0 143.0 147.0 145.0 144.0 07:12:06 INFO - PROCESS | 1670 | 07:12:06 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.52 (2.3%) stddev-sans-first:1.56 07:12:06 INFO - PROCESS | 1670 | Values: 68.0 67.0 66.0 66.0 69.0 66.0 65.0 68.0 69.0 65.0 07:12:06 INFO - PROCESS | 1670 | -------- Summary: end -------- 07:12:06 INFO - PROCESS | 1670 | 07:12:07 INFO - TEST-INFO | 1670: exit 0 07:12:07 INFO - TEST-OK | kraken | took 58625ms 07:12:07 INFO - TEST-START | v8_7 07:12:07 INFO - operating with platform_type : linux_ 07:12:07 INFO - Initialising browser for v8_7 test... 07:12:07 INFO - TEST-INFO | started process 1918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvAvdgK/profile http://localhost:53974/getInfo.html) 07:12:11 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 07:12:11 INFO - PROCESS | 1918 | colorDepth:24 07:12:11 INFO - PROCESS | 1918 | Browser inner width/height: 1024/697 07:12:11 INFO - PROCESS | 1918 | __metrics 07:12:11 INFO - PROCESS | 1918 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:12:11 INFO - PROCESS | 1918 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:12:12 INFO - TEST-INFO | 1918: exit 0 07:12:12 INFO - Browser initialized. 07:12:12 INFO - Running cycle 1/1 for v8_7 test... 07:12:12 INFO - TEST-INFO | started process 1998 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvAvdgK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:24 INFO - PROCESS | 1998 | RSS: Main: 149217280 07:12:24 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:53974/tests/v8_7/run.html (next: http://localhost:53974/tests/v8_7/run.html) 07:12:46 INFO - PROCESS | 1998 | RSS: Main: 556990464 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | __start_tp_report 07:12:46 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 07:12:46 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 07:12:46 INFO - PROCESS | 1998 | |i|pagename|runs| 07:12:46 INFO - PROCESS | 1998 | |0;Richards;166.08536787908986 07:12:46 INFO - PROCESS | 1998 | |1;DeltaBlue;188.7504718761797 07:12:46 INFO - PROCESS | 1998 | |2;Encrypt;279.79854504756577 07:12:46 INFO - PROCESS | 1998 | |3;Decrypt;5268.421052631579 07:12:46 INFO - PROCESS | 1998 | |4;RayTrace;1943.6893203883494 07:12:46 INFO - PROCESS | 1998 | |5;Earley;800 07:12:46 INFO - PROCESS | 1998 | |6;Boyer;11835.29411764706 07:12:46 INFO - PROCESS | 1998 | |7;RegExp;41469.38775510204 07:12:46 INFO - PROCESS | 1998 | |8;Splay;560.177481974487 07:12:46 INFO - PROCESS | 1998 | |9;NavierStokes;4826.923076923077 07:12:46 INFO - PROCESS | 1998 | __end_tp_report 07:12:46 INFO - PROCESS | 1998 | __startTimestamp1452870766897__endTimestamp 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | ------- Summary: start ------- 07:12:46 INFO - PROCESS | 1998 | Number of tests: 10 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#0] Richards Cycles:1 Average:166.09 Median:166.09 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 166.1 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 188.8 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 279.8 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 5268.4 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#4] RayTrace Cycles:1 Average:1943.69 Median:1943.69 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 1943.7 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 800.0 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#6] Boyer Cycles:1 Average:11835.29 Median:11835.29 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 11835.3 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#7] RegExp Cycles:1 Average:41469.39 Median:41469.39 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 41469.4 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#8] Splay Cycles:1 Average:560.18 Median:560.18 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 560.2 07:12:46 INFO - PROCESS | 1998 | 07:12:46 INFO - PROCESS | 1998 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:12:46 INFO - PROCESS | 1998 | Values: 4826.9 07:12:46 INFO - PROCESS | 1998 | -------- Summary: end -------- 07:12:46 INFO - PROCESS | 1998 | 07:12:47 INFO - TEST-INFO | 1998: exit 0 07:12:47 INFO - TEST-OK | v8_7 | took 40011ms 07:12:47 INFO - SUITE-END | took 1210s 07:12:47 INFO - Completed test suite (00:20:10) 07:12:47 INFO - Working with test: dromaeo_css 07:12:47 INFO - Generating results file: dromaeo_css 07:12:47 INFO - Working with test: kraken 07:12:47 INFO - Generating results file: kraken 07:12:47 INFO - javascript benchmark 07:12:47 INFO - Working with test: v8_7 07:12:47 INFO - Generating results file: v8_7 07:12:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:12:47 INFO - process_Request line: dromaeo_css 6708.67 graph.html#tests=[[72,1,35]] 07:12:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:47 INFO - process_Request line: kraken 1494.50 graph.html#tests=[[232,1,35]] 07:12:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:12:47 INFO - process_Request line: v8_7 19145.13 graph.html#tests=[[230,1,35]] 07:12:47 INFO - RETURN: dromaeo_css: 6708.67 07:12:47 INFO - RETURN: kraken: 1494.50 07:12:47 INFO - RETURN: v8_7: 19145.13 07:12:47 INFO - javascript benchmark 07:12:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3131.6398614159375, 3150.212446888278, 3191.473406887864, 3196.2009497625595, 3212.389645967266, 5014.122528557497, 5069.315642388272, 5102.693838369701, 5111.15665915124, 5122.948770512294, 5151.098557752397, 5183.688978661283, 5227.3465816772905, 5229.764660590273, 5239.423663397023, 4503.234450143484, 4691.835785747499, 4709.717416954976, 4740.502247264039, 4878.512148785128, 4770.809167633291, 4796.208625576775, 4822.156122678517, 4842.128416884977, 4846.4911184325665, 4644.489106198315, 4727.054589082198, 4730.385049943519, 4797.376341075673, 4826.951730482685, 4748.169070412699, 4751.667383283171, 4755.167845627036, 4755.2153894607345, 4788.233882578806, 4731.101090792738, 4737.905241895177, 4740.3837501124635, 4755.667103302771, 4760.381150450419, 4986.376702912136, 5028.773705183239, 5037.647364684473, 5075.746212689388, 5088.0, 5534.75093620788, 5569.136783798518, 5573.832785016456, 5581.190727344553, 5589.664620122806, 5327.227552004976, 5618.747156377973, 5619.971900140473, 5623.690697011662, 5628.915566266509, 5133.922991155136, 5265.76304066318, 5266.420693723688, 5287.550558202519, 5337.2527846101575, 5635.6618602883955, 5636.436356364413, 5651.0, 5656.717164141776, 5668.659880407106, 5383.0, 5465.890682186334, 5469.288992430958, 5469.781208751685, 5471.37079235893, 5599.496045355938, 5616.550675945915, 5619.634723742944, 5620.960122377292, 5639.492445679908, 5506.531944784658, 5558.610897237236, 5563.99848027359, 5569.470900264469, 5570.275864137636, 5390.245365648812, 5465.262189604432, 5536.307961504812, 5566.35986861508, 5607.130894711327, 4333.848315308949, 4342.478902531653, 4350.9564904350555, 4377.671674624416, 4383.890402739893, 3872.380419132925, 3879.1465877506903, 3881.7670939743707, 3908.863189788344, 3918.6081391860585, 5126.410462796826, 5205.609579281569, 5211.400688920747, 5221.660592061504, 5306.946930530722, 5576.832695019156, 5583.692896890629, 5606.747696353674, 5610.803621873215, 5611.102223644198, 5207.895842083137, 5219.660722053054, 5225.555827754607, 5225.843224703265, 5271.42014378418, 4707.576318131385, 4780.808767649255, 4797.616190704735, 4810.39870016248, 4866.367372241586, 5682.77268909239, 5682.914756278659, 5687.232223649837, 5697.601167918288, 5710.571707121982, 5461.781528738806, 5488.91766623493, 5494.1556826660035, 5503.3395992481155, 5544.500994910478, 5642.322921249476, 5643.548516118783, 5792.21805056312, 5834.38738932406, 5843.678597677169, 5435.184722291688, 5452.727363631882, 5455.781768729206, 5457.454254574511, 5459.781608735765, 5427.077396842467, 5522.0, 5522.282103326542, 5523.779048838162, 5524.4199359066715, 5413.53984911287, 5436.565074793928, 5438.83683489496, 5441.29263195782, 5444.6188766785945, 5402.486763757437, 5407.918881216706, 5412.107002344569, 5413.891722165614, 5415.756290966995, 5320.787168513216, 5329.7068661224, 5331.386890507486, 5334.226537152169, 5342.252084708066, 5486.039943009878, 5555.3611334697025, 5564.0, 5601.887962240651, 5619.269494965792, 5299.549538289289, 5332.200169974535, 5350.866228344323, 5351.892962140658, 5401.351837779492], "unit": "score", "name": "dojo.html", "value": 5133.67136675734}, {"lowerIsBetter": false, "replicates": [525.2488940814635, 535.7642637239616, 560.9130584759362, 581.5492992930479, 598.025218893204, 28793.568096478542, 36909.81545092274, 37247.62752372479, 37289.627103728955, 37306.253874922484, 39887.0, 40358.19283614326, 40377.19245615093, 40514.0, 40521.59478405215, 8399.832003359945, 8591.35564832637, 8594.0, 8601.483910965331, 8603.0, 8386.87419688705, 8408.495490270572, 8508.702195423162, 8512.106228845974, 8696.652133914637, 8558.743237702878, 8684.956575217115, 8698.260647844942, 8741.4755114693, 8754.255888249507, 8619.784505387384, 8626.094260102724, 8709.477431354107, 8712.912870871336, 8714.433561818525, 8498.70254541088, 8583.227509524111, 8603.096674849114, 8628.568571571397, 8630.65477380904, 39397.80301098505, 39826.0, 39840.800795996125, 39862.60137398618, 39890.40164397536, 2903.172595810205, 3193.2815116598813, 3367.9494807577908, 3425.4348032574844, 3766.0773110587807, 25923.611145832827, 26149.869250653624, 26192.8690356547, 26293.342666433302, 26748.06381776648, 3614.0964758810296, 3880.708946828999, 3893.9415908761393, 3937.625925537069, 4044.8382064717375, 218579.0, 220205.0, 220528.0, 221150.0, 221169.0, 54726.0, 55866.16200756992, 56067.0, 56127.15809262864, 56165.43834561602, 66335.33664663292, 66923.33076669268, 67206.66396667986, 67233.98298050968, 67272.66363668151, 14235.217063061631, 14398.20809855447, 14418.206998615176, 14424.423023079169, 14434.422623095168, 9840.704778856645, 10031.849522257173, 11209.831852522218, 11284.774304513863, 11325.150613704005, 20009.899950500156, 20193.495162621053, 20231.86406107056, 20304.898475507824, 20404.693929591067, 7760.758278675385, 7970.851513652075, 7986.281234688906, 8015.318697910743, 8020.639071241691, 887.8756974023642, 942.6229508196776, 961.9807603847884, 1036.9429681367596, 1081.6754973508073, 29342.0, 29640.703592964226, 31485.685143148734, 33299.66700333014, 33912.0, 1010.2978429991233, 1039.3919557059205, 1095.5070218401593, 1107.0147568663895, 1137.8748337682848, 15120.697586048438, 15275.541733748005, 15370.769438458432, 15384.538463846102, 15618.0, 401051.0, 402887.0, 403154.0, 409382.0, 410484.0, 55120.0, 55223.17165242525, 55599.444005559424, 55627.72186139043, 55666.16500752492, 1332.3338330834583, 1340.0217840975947, 1349.3860293566404, 1359.6261028217123, 1361.4350044731325, 28844.278893027844, 29200.56199157057, 29236.83052677869, 29626.407471850875, 29828.254293641963, 47381.289280661505, 48242.75878620584, 48283.27575086306, 48292.7585362071, 48297.75851120722, 303830.0, 307748.0, 307828.0, 308078.0, 308616.0, 28211.43577128487, 28728.13815585536, 32130.0, 32686.34627307488, 33089.834550827094, 37651.435228472146, 38319.23361532698, 38413.039674008374, 38581.807090964365, 38619.420708689955, 32374.83812580922, 33655.15862103369, 34502.30995380028, 35135.29729405347, 35272.470912935816, 29493.26266843346, 34342.656573433946, 34978.47532287068, 35374.823125884206, 35489.29021419609, 32276.35447291088, 33023.66976330206, 33278.0, 33287.33425331528, 33525.329493410485, 29053.273668158465, 29623.451857771193, 31220.0, 32257.193570160933, 32276.0, 23668.763312366656, 23845.761542385048, 23848.642270366305, 24007.63988540208, 24302.635460467754], "unit": "score", "name": "ext.html", "value": 18215.28726402772}, {"lowerIsBetter": false, "replicates": [367.88043885737136, 369.5270054330457, 370.3944051475836, 370.8368317940106, 378.5419642232898, 13685.726285474284, 13731.931340343284, 15425.15161666108, 16406.589835254126, 17120.74318885218, 15260.771088433683, 15579.53261402157, 15595.376184952616, 15690.450834220805, 16549.089800060992, 5201.297824793652, 5385.030694474993, 5387.542058924996, 5387.946120538783, 5390.91913621294, 3945.9210815783667, 4041.211963667086, 5283.418823929364, 5347.732613369335, 5602.747876345574, 5723.627964182336, 5752.050911599581, 5776.451237132465, 5779.9422005779825, 5781.277340332458, 5080.923786143211, 5245.318108645852, 5263.131583288791, 5266.210068489738, 5266.499682530153, 4923.261510773377, 5047.798088076473, 5095.541401273903, 5095.668781529226, 5096.362954630671, 12477.875221247763, 13058.412371443308, 18094.819051809445, 18696.532586685305, 18734.1569629367, 1932.2657390191778, 1952.4435535872208, 1977.5451646121473, 2067.1421360135528, 2117.788221177885, 8720.345974051972, 9113.407628504192, 9239.861402078974, 9247.12152345526, 9289.953550232272, 1707.538964479596, 1714.13436214712, 1772.7163653815328, 1824.662437449063, 1850.5928695687062, 55838.44161558373, 57028.144577831365, 57087.42912570863, 57115.428845711845, 57575.71212143912, 9729.805403891882, 9770.267229957639, 9827.754306142404, 9863.605455781832, 9992.850107248398, 12686.80969785454, 12709.237445753284, 12728.745425091447, 12751.872481275253, 12763.553275635308, 6906.861862762717, 7191.496595238283, 7202.0, 7207.279272072751, 7260.346568808833, 6974.651267436608, 6978.685959131852, 7007.124109486314, 7016.964915175391, 7033.929660703429, 4109.835606575763, 4120.91758164835, 4141.979290103591, 4143.274926887782, 4172.311568591209, 1720.2946791815295, 1743.1371471121622, 1791.6105541423565, 1849.7317888906034, 1861.7300491428666, 456.76248350857367, 461.33106994857593, 472.04882162442703, 818.8157664525434, 1002.478711070254, 10133.240006999504, 10374.118199952938, 10392.168626509861, 10444.791104177873, 10586.947065264625, 405.4222732606025, 458.7591514454938, 465.43217274924535, 475.916714574948, 489.33939182103876, 5834.3290521589715, 6021.7591296347655, 6104.633721976696, 6143.201383820164, 6156.907646385308, 537836.0, 538061.0, 549394.0, 554188.0, 554361.0, 67557.0, 72257.63871180611, 74446.0, 75054.0, 75102.62448687722, 1123.9550417983353, 1148.9138314626437, 1149.5631659969158, 1155.3241353808116, 1162.8837116288303, 14423.639409014439, 14477.348519316867, 14651.82785377146, 14872.405103795727, 14911.776323355376, 32047.35905281928, 32756.181095472803, 32768.0, 33060.1734956628, 33909.49135763015, 43899.0, 44924.77537612422, 45123.323150152115, 45921.31118033299, 46379.30431043605, 6902.240753517009, 7174.641267936687, 7178.712851485882, 7222.89165662526, 7278.017467641801, 10358.223133265186, 10767.300125491818, 11061.170412219277, 11094.500747466222, 11695.12286578493, 9177.678781242625, 9475.289353298667, 9811.313208075651, 10122.79754404893, 10218.1825453965, 9132.726018219464, 9228.169464747936, 9286.489243091695, 9512.714618561455, 9738.513074346112, 7707.845843082995, 9489.0, 9865.260105491972, 9959.551820168255, 10065.446400448045, 7254.274572542704, 7425.480216385017, 7477.887831682638, 7500.212477689982, 7504.287092726182, 8272.917270827455, 9955.900440995498, 10040.246981476272, 10108.393496389946, 10190.592376304865], "unit": "score", "name": "jquery.html", "value": 7572.1949142881895}, {"lowerIsBetter": false, "replicates": [1329.3884812986025, 1506.2920427399122, 1508.818941726993, 1683.9326426942923, 1825.297260554686, 6508.772192973241, 7461.060124367663, 7562.924370756291, 7580.507267027653, 7580.734674286401, 7456.440766942487, 7629.9237007630045, 7645.1590325064335, 7647.694092236317, 7654.770356889288, 1973.4079776067194, 2016.6168427998707, 2019.5355068334218, 2299.678045073687, 2329.487512747193, 2001.1595130045416, 2290.3930458428445, 2314.0396735354893, 2321.558903808271, 2326.2672258238686, 2301.735300440454, 2311.1217737259904, 2311.43369874381, 2312.6877871487304, 2402.8077753779744, 2235.2623634200677, 2267.8299127565497, 2280.09936075251, 2282.3837563857833, 2286.4283929017747, 2283.315005498344, 2283.5775381554467, 2286.188403116903, 2288.645259984705, 2291.026313816638, 7660.2722741339485, 7711.190325015848, 7767.495112817649, 7767.766966990943, 7771.961140194319, 4808.855734327975, 4885.145099607555, 4904.190808516591, 4911.729854857981, 4914.140025495524, 2963.2443726849733, 3041.950527068158, 3090.9381812363627, 3126.6873312668777, 3138.529220616903, 946.7727745341138, 970.2092794372634, 992.0575453319375, 992.5831150916632, 1000.4447531619948, 10520.105791007774, 10531.210159238011, 10564.894351056544, 10590.152787777037, 10635.787284254271, 4372.1692878353015, 4402.075564131568, 4421.756803375781, 4433.113377324548, 4456.46522417312, 9212.907870921204, 9214.815703686023, 9215.815683686289, 9217.44695318283, 9223.815523689489, 4872.561469467765, 4883.145449546315, 4897.95102048975, 4898.485659005824, 4900.656954013185, 4425.491068527161, 4428.114377124588, 4465.352523884018, 4465.508794032654, 4469.262571675637, 3368.1579605098727, 3429.3141371725756, 3743.6335737455634, 3836.731428800013, 3851.441540976543, 1209.60687776473, 1209.6129238643725, 1219.664592237142, 1221.828943947848, 1224.9265044097383, 1037.190991027, 1057.3655806516028, 1057.836035414512, 1181.1082632612322, 1310.4823594680047, 7086.2205157432645, 7112.466565007645, 7135.108111486064, 7151.427885769126, 7160.57036577807, 1105.0993440346092, 1121.9775604487866, 1134.7163209197702, 1135.4833550734395, 1137.2607804926863, 5762.769489220468, 5854.473097421167, 5860.853478663067, 5861.472467477947, 5865.970670146622, 8821.911780882108, 8831.779205519913, 8971.955140224258, 9006.774830629156, 9057.230135438562, 9033.50315732641, 9053.094690530894, 9097.363184577149, 9100.271978241724, 9103.089691030844, 7020.543664661883, 7150.499465037397, 7218.278172182845, 7220.494565380478, 7284.235155308722, 7231.963840180765, 7312.890306645299, 7320.963395183203, 7337.3029562191505, 7346.669399877125, 8056.154103819014, 8341.708040218564, 8408.747737567883, 8420.15798420153, 8447.788805279917, 8106.797330066795, 8299.917000829915, 8300.958495207486, 8475.0, 8482.61828217744, 6741.932580674131, 6935.479839012195, 6940.444764418733, 6954.652267386509, 6956.2000369958105, 6419.261784894797, 6562.606243625398, 7218.205997340393, 7395.630218488946, 7456.9254307458405, 6970.79087627372, 6992.440604751506, 7109.0402795623995, 7149.53528020677, 7155.4633402496065, 6808.761693340709, 6943.027976083454, 6944.270851560514, 7022.859542809218, 7066.646667666699, 6947.895781563382, 6980.965095174492, 6984.26665200167, 6989.986451964538, 6991.265917078634, 6362.300146983735, 6439.967800160969, 6449.290578036506, 6459.741610335534, 6529.379708927644, 6435.22777266731, 6449.516286278454, 6477.125588045554, 6478.0, 6491.156149700509], "unit": "score", "name": "mootools.html", "value": 4471.79358612972}, {"lowerIsBetter": false, "replicates": [335.9177001634599, 344.94998225257336, 347.8173958671697, 352.3850880214027, 357.4745124666739, 5743.425657434254, 5761.971190144049, 5762.0, 5788.305403351598, 5905.940940590593, 5665.943340566593, 5823.767049318033, 5826.999999999989, 5856.2094117294155, 5857.8828423431505, 4521.8417355392485, 4533.682642215046, 4534.161180181661, 4534.523874993128, 4538.205813982539, 4325.9351109733225, 4397.296432570789, 4418.2709852874395, 4512.571305725951, 4530.048689775152, 4442.800443880151, 4461.442319710036, 4462.0183559616835, 4462.910741785162, 4473.463184417875, 4454.198244316021, 4464.575865292792, 4468.0, 4468.731876087412, 4470.061287129706, 3903.1608204236227, 3907.6678482329035, 3908.355121404965, 3911.647951684362, 3911.863084792047, 5437.211604317352, 5587.497125258747, 5595.524380427669, 5609.663420194802, 5623.100303951348, 5209.296744939423, 5213.713245771481, 5215.6349055566125, 5215.947840521584, 5217.217417387385, 5905.232319798399, 6215.7513699451965, 6218.284897236786, 6220.098085777582, 6225.564210505267, 4263.083437061046, 4264.381664658638, 4331.090471001062, 4364.781760911974, 4373.562643735633, 6351.0, 6495.285518592951, 6527.804165875032, 6540.182477190351, 6541.47668186544, 4436.134953684001, 4437.0, 4438.667099967515, 4440.156370289635, 4450.777461126995, 4408.404865343202, 4412.867613971586, 4494.16857881293, 4495.43807024122, 4515.367848501212, 5179.766910489037, 5183.714895680774, 5183.974080129575, 5189.273501709764, 5193.324867767242, 6233.470155036873, 6238.095476155932, 6238.469730072904, 6242.531810114259, 6243.656598887105, 1559.4463965292384, 1580.5100418870188, 1583.9683206335808, 1584.3900098462175, 1586.8730501559849, 1066.1044722433194, 1066.1950227578284, 1068.2468859454066, 1075.198976762317, 1097.1716354152563, 5855.414458554111, 5861.648301101947, 5867.413258674099, 5904.439078287556, 5912.0, 6401.03984402334, 6426.453751431087, 6438.452731517874, 6440.645764482999, 6459.903101453482, 5906.379830117861, 5915.1718759373725, 5917.704114794243, 5919.733611987471, 5920.79277225295, 3393.3891899458336, 3487.4943133246043, 3492.4237500812587, 3493.4235851084795, 3494.4583589543663, 6737.258901520829, 6737.831554211086, 6755.020522024279, 6758.290379510081, 6758.560693554903, 6673.699683514254, 6673.9332606673315, 6675.766348177791, 6680.03139544773, 6687.364700353459, 6557.0, 6717.563358381787, 6732.899006514906, 6741.561798483083, 6744.325567443217, 6228.532860035606, 6395.360463953567, 6499.707513162014, 6511.9348806511325, 6520.087187793808, 6262.405071518198, 6383.457406120532, 6405.135306733531, 6409.7115629795835, 6413.775517856852, 6707.496937729592, 6711.563748356341, 6713.160854893138, 6715.328467153246, 6723.4957378197805, 4319.784010799511, 4421.579949904753, 4464.977675111603, 4468.932966005447, 4471.754053527087, 6368.044793281045, 6388.840278993062, 6389.265234497906, 6408.455281301141, 6445.1943507061615, 6292.056191571301, 6297.811065668037, 6298.779542715983, 6299.779507717208, 6301.684915754102, 6183.752649893954, 6194.4115309045565, 6270.655113968775, 6277.686115694289, 6290.0879372491645, 6156.6921653918025, 6164.0, 6167.876642467215, 6170.444659980623, 6180.721867516063, 6283.874322513433, 6288.056791481315, 6298.779542715983, 6300.086487459201, 6314.463270622048, 6062.969685151546, 6143.078538219124, 6153.876922461615, 6161.168242287413, 6171.228596425447], "unit": "score", "name": "prototype.html", "value": 4712.0488843067715}, {"lowerIsBetter": false, "replicates": [760.4638729695565, 782.8629989751796, 826.1160558202722, 850.3239924260213, 861.9698310559131, 12830.679233019167, 13008.544700935468, 13102.475900963962, 13131.474741010348, 13132.146410483312, 12489.68775780606, 13039.543615973444, 13042.413091410886, 13053.543125990593, 13061.085723999324, 660.1088530483856, 663.4360793325683, 791.2325044706654, 810.1493431896486, 825.1500954017372, 807.2774866494484, 818.7625588579334, 820.6184124382161, 822.2887202569764, 823.4318320358963, 694.3958755882389, 850.2517784349764, 852.4629483425464, 853.9231469167773, 854.1287886355914, 685.9245482996866, 841.64915310926, 856.567433446112, 857.8455877941968, 857.9828403431927, 628.1770880147022, 628.3841835001724, 628.5600079944012, 629.0469938043867, 629.26061877294, 10776.67669969902, 10821.513031913582, 10836.945815270874, 10864.239503234776, 10901.182411319103, 11785.941070294593, 11950.163488555805, 12077.214981026205, 12259.241670624127, 12799.0, 9775.853362199572, 9823.115919567274, 9899.208063354914, 10029.949850250701, 10040.347377420445, 3474.2530355973586, 3493.8427770750122, 3572.517710109128, 3574.803385813779, 3589.910252243689, 46056.53943460556, 46101.53898461039, 46315.30527042097, 46367.53632463666, 46517.30224046642, 9677.000908029593, 9887.555060022316, 9903.851442228228, 10144.644937427154, 10431.269811113149, 18079.186436610384, 18671.066446677884, 18684.34604788826, 18752.0, 18799.0, 7436.814079648052, 7472.065991751031, 7500.062492188476, 7518.774436766906, 7573.772786816405, 3948.861789837342, 3998.7400818946676, 4031.879043628696, 4091.3453847384276, 4117.197146556453, 2982.731554160136, 2994.1915682765966, 3003.039027511219, 3005.3087789808465, 3005.443992861328, 566.9121286200645, 578.3522454850511, 585.5257241634205, 597.5876645114856, 599.2748773983528, 540.572947371572, 556.6910364747523, 655.7278729327371, 661.0777964739162, 699.7461802617868, 8465.534395608302, 8503.582049538067, 8508.702195423131, 8616.267617252604, 8659.567021648892, 519.2159838643676, 546.0635010956229, 581.813819577731, 596.9323213156251, 619.4239357397663, 3906.121122747416, 3952.9011774705286, 3970.8808735737975, 4034.374671925856, 4130.256553820281, 56981.43018569844, 57387.426125739046, 57479.712601436724, 57656.0, 57667.423325766205, 47725.522744772104, 47971.280430793566, 48669.51330486721, 48734.75632621814, 49729.25406118911, 44066.779666101465, 44761.0, 45034.77482612566, 45714.31428528508, 45945.31082033772, 8053.798655033671, 8061.677532898853, 8834.514101724468, 8895.2883769297, 8994.370394072352, 33959.92790417823, 34519.82740086384, 34572.654273456945, 35347.293054139285, 35389.64610353864, 40607.1878562433, 40682.0, 43391.34912976245, 45169.54830451653, 45810.0, 10064.29549931527, 10196.286259961731, 10594.523246454082, 10755.838662420227, 10768.138548915911, 11570.305781653127, 11641.6507504775, 11929.701757456132, 11973.221740586834, 12370.381480926098, 10282.691519254435, 10644.308119972176, 10840.186985975926, 10857.945710271399, 11270.088025902864, 11411.60059397917, 11474.483648235682, 11514.481848316678, 11611.825822612498, 11872.881271187178, 9682.951585242028, 9953.353032052893, 10058.698239052841, 10152.949235253776, 10290.948545257525, 8504.872426913726, 8702.216800487986, 8846.98259700117, 8886.289096872364, 9017.09829017093, 9146.176844084064, 9442.81114377695, 9519.0, 9781.902180978099, 9850.98430102168], "unit": "score", "name": "yui.html", "value": 6109.504315926148}], "name": "dromaeo_css", "value": 6708.676551344949}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 108.0, 110.0, 109.0, 99.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 147.0, 168.0, 129.0, 151.0, 161.0, 127.0, 178.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 163.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 99.0, 100.0, 72.0, 70.0, 74.0, 113.0, 93.0, 70.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 141.0, 95.0, 96.0, 96.0, 144.0, 95.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 108.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 101.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 55.0, 53.0, 55.0, 61.0, 63.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [94.0, 84.0, 92.0, 82.0, 81.0, 81.0, 83.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 117.0, 123.0, 112.0, 123.0, 113.0, 112.0, 115.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [142.0, 134.0, 144.0, 145.0, 148.0, 143.0, 143.0, 147.0, 145.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 69.0, 66.0, 65.0, 68.0, 69.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1494.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.08536787908986], "unit": "score", "name": "Richards", "value": 212.55334200000007}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1943.6893203883494], "unit": "score", "name": "RayTrace", "value": 380.7136213786215}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [11835.29411764706], "unit": "score", "name": "Boyer", "value": 56.311486083499055}, {"lowerIsBetter": false, "replicates": [41469.38775510204], "unit": "score", "name": "RegExp", "value": 21.96765009842518}, {"lowerIsBetter": false, "replicates": [560.177481974487], "unit": "score", "name": "Splay", "value": 145.47353762376233}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19145.12933992343}]} 07:12:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19145.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1494.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6708.67"}}} 07:12:48 INFO - Return code: 0 07:12:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:12:48 INFO - # TBPL SUCCESS # 07:12:48 INFO - Running post-action listener: _resource_record_post_action 07:12:48 INFO - Running post-run listener: _resource_record_post_run 07:12:49 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539996160; Read time: 372; Write time: 456540 07:12:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237113344; Read time: 200; Write time: 261500 07:12:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302882816; Read time: 172; Write time: 195040 07:12:49 INFO - Running post-run listener: _upload_blobber_files 07:12:49 INFO - Blob upload gear active. 07:12:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:12:49 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 07:12:49 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'] 07:12:49 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 07:12:49 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:12:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:12:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:50 INFO - (blobuploader) - INFO - Done attempting. 07:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:12:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:51 INFO - (blobuploader) - INFO - Done attempting. 07:12:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:51 INFO - Return code: 0 07:12:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:12:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a75b46e42f7e037d6e4836c0ca18b78b44c754fbf82189d3871e96c5afb9786ef40584d80c49acf4c36dbdbe6db36eb0e85b21f4fbca966b2f140ab7f6e3c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff39559bec938c5624beeff9f51510b16678f9a03bbb300076090f2312a31e69f729ef7856ff65602768af60b6cf4a1b25385b09f1862e8a71e2116e09610b0"} 07:12:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:12:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:12:51 INFO - Contents: 07:12:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a75b46e42f7e037d6e4836c0ca18b78b44c754fbf82189d3871e96c5afb9786ef40584d80c49acf4c36dbdbe6db36eb0e85b21f4fbca966b2f140ab7f6e3c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff39559bec938c5624beeff9f51510b16678f9a03bbb300076090f2312a31e69f729ef7856ff65602768af60b6cf4a1b25385b09f1862e8a71e2116e09610b0"} 07:12:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:51 INFO - Copying logs to upload dir... 07:12:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:12:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.504593 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 07:12:51.496247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:51.500036) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 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/a75b46e42f7e037d6e4836c0ca18b78b44c754fbf82189d3871e96c5afb9786ef40584d80c49acf4c36dbdbe6db36eb0e85b21f4fbca966b2f140ab7f6e3c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff39559bec938c5624beeff9f51510b16678f9a03bbb300076090f2312a31e69f729ef7856ff65602768af60b6cf4a1b25385b09f1862e8a71e2116e09610b0"} build_url:https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/a6XODH0JTW20Ez0Pjfbtvg/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/a75b46e42f7e037d6e4836c0ca18b78b44c754fbf82189d3871e96c5afb9786ef40584d80c49acf4c36dbdbe6db36eb0e85b21f4fbca966b2f140ab7f6e3c710", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ff39559bec938c5624beeff9f51510b16678f9a03bbb300076090f2312a31e69f729ef7856ff65602768af60b6cf4a1b25385b09f1862e8a71e2116e09610b0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:51.525003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:51.525332) ========= 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=4ac8d263c7293b36a1be1aed000001be-1452869227.712825-685780073 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 07:12:51.607639) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:12:51.607981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 07:12:51.608337) ========= ========= Total master_lag: 0.25 =========