builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1450767507.02 results: success (0) buildid: 20151221203114 builduid: b59ed20c6ab442beb62ad49f1fedcfdd revision: 0db21edafc584d96b7ce682145d99d7df0b643de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.021578) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.022088) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.022505) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.054313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.054637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.108194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.108502) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.159492) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.159833) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.160241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.160570) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 22:58:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-21 22:58:27 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.340408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.340761) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021317 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.390274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:27.390711) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0db21edafc584d96b7ce682145d99d7df0b643de --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0db21edafc584d96b7ce682145d99d7df0b643de --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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 22:58:27,835 truncating revision to first 12 chars 2015-12-21 22:58:27,835 Setting DEBUG logging. 2015-12-21 22:58:27,835 attempt 1/10 2015-12-21 22:58:27,835 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0db21edafc58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 22:58:28,203 unpacking tar archive at: b2g-inbound-0db21edafc58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644364 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:28.048297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:28.048649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:28.058969) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:28.059452) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 22:58:28.059998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 22:58:28.060345) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:58:28 INFO - MultiFileLogger online at 20151221 22:58:28 in /builds/slave/test-pgo 22:58:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:58:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:58:28 INFO - {'append_to_log': False, 22:58:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:58:28 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:58:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:58:28 INFO - 'branch': 'B2G-Inbound', 22:58:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:58:28 INFO - 'config_files': ('talos/linux_config.py',), 22:58:28 INFO - 'default_actions': ('clobber', 22:58:28 INFO - 'read-buildbot-config', 22:58:28 INFO - 'download-and-extract', 22:58:28 INFO - 'populate-webroot', 22:58:28 INFO - 'create-virtualenv', 22:58:28 INFO - 'install', 22:58:28 INFO - 'run-tests'), 22:58:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:58:28 INFO - 'download_minidump_stackwalk': True, 22:58:28 INFO - 'download_symbols': 'ondemand', 22:58:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:58:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:58:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:58:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:58:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:58:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:58:28 INFO - 'installer_path': 'installer.exe', 22:58:28 INFO - 'log_level': 'info', 22:58:28 INFO - 'log_name': 'talos', 22:58:28 INFO - 'log_to_console': True, 22:58:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:58:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:58:28 INFO - 'opt_config_files': (), 22:58:28 INFO - 'pip_index': False, 22:58:28 INFO - 'sps_profile': False, 22:58:28 INFO - 'sps_profile_interval': 0, 22:58:28 INFO - 'suite': 'dromaeojs', 22:58:28 INFO - 'system_bits': '64', 22:58:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:58:28 INFO - 'title': 'talos-linux64-ix-037', 22:58:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:58:28 INFO - 'use_talos_json': True, 22:58:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:58:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:58:28 INFO - 'work_dir': 'build'} 22:58:28 INFO - ##### 22:58:28 INFO - ##### Running clobber step. 22:58:28 INFO - ##### 22:58:28 INFO - Running pre-action listener: _resource_record_pre_action 22:58:28 INFO - Running main action method: clobber 22:58:28 INFO - rmtree: /builds/slave/test-pgo/build 22:58:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:58:29 INFO - Running post-action listener: _resource_record_post_action 22:58:29 INFO - ##### 22:58:29 INFO - ##### Running read-buildbot-config step. 22:58:29 INFO - ##### 22:58:29 INFO - Running pre-action listener: _resource_record_pre_action 22:58:29 INFO - Running main action method: read_buildbot_config 22:58:29 INFO - Using buildbot properties: 22:58:29 INFO - { 22:58:29 INFO - "project": "", 22:58:29 INFO - "product": "firefox", 22:58:29 INFO - "script_repo_revision": "production", 22:58:29 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:58:29 INFO - "repository": "", 22:58:29 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:58:29 INFO - "buildid": "20151221203114", 22:58:29 INFO - "pgo_build": "True", 22:58:29 INFO - "basedir": "/builds/slave/test-pgo", 22:58:29 INFO - "buildnumber": 141, 22:58:29 INFO - "slavename": "talos-linux64-ix-037", 22:58:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:58:29 INFO - "platform": "ubuntu64_hw", 22:58:29 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:58:29 INFO - "branch": "b2g-inbound", 22:58:29 INFO - "repo_path": "integration/b2g-inbound", 22:58:29 INFO - "revision": "0db21edafc584d96b7ce682145d99d7df0b643de", 22:58:29 INFO - "stage_platform": "linux64-pgo", 22:58:29 INFO - "builduid": "b59ed20c6ab442beb62ad49f1fedcfdd", 22:58:29 INFO - "slavebuilddir": "test" 22:58:29 INFO - } 22:58:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:58:29 INFO - Running post-action listener: _resource_record_post_action 22:58:29 INFO - ##### 22:58:29 INFO - ##### Running download-and-extract step. 22:58:29 INFO - ##### 22:58:29 INFO - Running pre-action listener: _resource_record_pre_action 22:58:29 INFO - Running main action method: download_and_extract 22:58:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:29 INFO - https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/test_packages.json 22:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/test_packages.json 22:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:58:30 INFO - Downloaded 1302 bytes. 22:58:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:58:30 INFO - Using the following test package requirements: 22:58:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:58:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'jsshell-linux-x86_64.zip'], 22:58:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:58:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:58:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:58:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:58:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:58:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:58:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:58:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:58:30 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')]} 22:58:30 INFO - https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:32 INFO - Downloaded 23174975 bytes. 22:58:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:33 INFO - Return code: 0 22:58:33 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 22:58: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')]} 22:58:33 INFO - https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:35 INFO - Downloaded 23174975 bytes. 22:58:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:58:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:58:36 INFO - Return code: 0 22:58: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')]} 22:58:36 INFO - https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:38 INFO - Downloaded 11132277 bytes. 22:58:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:58:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:58:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:58:38 INFO - Return code: 0 22:58:38 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')]} 22:58:38 INFO - https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mTTDntvvQUmxCtJED5cC2Q/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 22:58:42 INFO - Downloaded 54930128 bytes. 22:58:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:42 INFO - mkdir: /builds/slave/test-pgo/properties 22:58:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:58:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:58:42 INFO - Contents: 22:58:42 INFO - build_url:https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:58:42 INFO - Running post-action listener: _resource_record_post_action 22:58:42 INFO - Running post-action listener: set_extra_try_arguments 22:58:42 INFO - ##### 22:58:42 INFO - ##### Running populate-webroot step. 22:58:42 INFO - ##### 22:58:42 INFO - Running pre-action listener: _resource_record_pre_action 22:58:42 INFO - Running main action method: populate_webroot 22:58:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:58:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:58:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:58:42 INFO - '--tppagecycles', 22:58:42 INFO - '7'], 22:58:42 INFO - 'tests': ['tsvgm']}}, 22:58:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:58:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:58:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:58:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:58:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'tests': ['damp', 'tps']}, 22:58:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['damp', 'tps']}, 22:58:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:58:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:58:42 INFO - 'other': {'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'other_l64': {'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'other_nol64': {'tests': ['a11yr', 22:58:42 INFO - 'ts_paint', 22:58:42 INFO - 'tpaint', 22:58:42 INFO - 'sessionrestore', 22:58:42 INFO - 'sessionrestore_no_auto_restore']}, 22:58:42 INFO - 'svgr': {'tests': ['tsvgx', 22:58:42 INFO - 'tsvgr_opacity', 22:58:42 INFO - 'tart', 22:58:42 INFO - 'tscrollx', 22:58:42 INFO - 'cart']}, 22:58:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['tsvgx', 22:58:42 INFO - 'tsvgr_opacity', 22:58:42 INFO - 'tart', 22:58:42 INFO - 'tscrollx', 22:58:42 INFO - 'cart']}, 22:58:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'tests': ['tp5o']}, 22:58:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'talos_options': ['--e10s'], 22:58:42 INFO - 'tests': ['tp5o']}, 22:58:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'talos_options': ['--xperf_path', 22:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:42 INFO - 'tests': ['tp5n']}, 22:58:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:58:42 INFO - 'talos_options': ['--e10s', 22:58:42 INFO - '--xperf_path', 22:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:58:42 INFO - 'tests': ['tp5n']}}, 22:58:42 INFO - 'talos.zip': {'path': '', 22:58:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:58:42 INFO - Running post-action listener: _resource_record_post_action 22:58:42 INFO - ##### 22:58:42 INFO - ##### Running create-virtualenv step. 22:58:42 INFO - ##### 22:58:42 INFO - Running pre-action listener: _resource_record_pre_action 22:58:42 INFO - Running main action method: create_virtualenv 22:58:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:58:42 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 22:58:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:58:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:58:42 INFO - Using real prefix '/usr' 22:58:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:58:42 INFO - Installing distribute.............................................................................................................................................................................................done. 22:58:44 INFO - Installing pip.................done. 22:58:44 INFO - Return code: 0 22:58:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:44 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:44 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 22:58:44 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 22:58:44 INFO - Using env: {'DISPLAY': ':0', 22:58:44 INFO - 'HOME': '/home/cltbld', 22:58:44 INFO - 'LANG': 'en_US.UTF-8', 22:58:44 INFO - 'LANGUAGE': 'en_US:en', 22:58:44 INFO - 'LOGNAME': 'cltbld', 22:58:44 INFO - 'MAIL': '/var/mail/cltbld', 22:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:44 INFO - 'MOZ_NO_REMOTE': '1', 22:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:44 INFO - 'NO_EM_RESTART': '1', 22:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:44 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:44 INFO - 'SHELL': '/bin/bash', 22:58:44 INFO - 'SHLVL': '1', 22:58:44 INFO - 'TERM': 'linux', 22:58:44 INFO - 'TMOUT': '86400', 22:58:44 INFO - 'USER': 'cltbld', 22:58:44 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:44 INFO - '_': '/tools/buildbot/bin/python'} 22:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:45 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 22:58:45 INFO - Cleaning up... 22:58:45 INFO - Return code: 0 22:58:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:58:45 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')]} 22:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:45 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')]} 22:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:45 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:45 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 22:58:45 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 22:58:45 INFO - Using env: {'DISPLAY': ':0', 22:58:45 INFO - 'HOME': '/home/cltbld', 22:58:45 INFO - 'LANG': 'en_US.UTF-8', 22:58:45 INFO - 'LANGUAGE': 'en_US:en', 22:58:45 INFO - 'LOGNAME': 'cltbld', 22:58:45 INFO - 'MAIL': '/var/mail/cltbld', 22:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:45 INFO - 'MOZ_NO_REMOTE': '1', 22:58:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:45 INFO - 'NO_EM_RESTART': '1', 22:58:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:45 INFO - 'SHELL': '/bin/bash', 22:58:45 INFO - 'SHLVL': '1', 22:58:45 INFO - 'TERM': 'linux', 22:58:45 INFO - 'TMOUT': '86400', 22:58:45 INFO - 'USER': 'cltbld', 22:58:45 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:45 INFO - '_': '/tools/buildbot/bin/python'} 22:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:45 INFO - Downloading/unpacking psutil>=0.7.1 22:58:45 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 22:58:45 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 22:58:45 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 22:58:45 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 22:58:45 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 22:58:45 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 22:58:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:58:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:58:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:58:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:47 INFO - Installing collected packages: psutil 22:58:47 INFO - Running setup.py install for psutil 22:58:47 INFO - building 'psutil._psutil_linux' extension 22:58:47 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 22:58:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:58:47 INFO - building 'psutil._psutil_posix' extension 22:58:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:58:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:58:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:58:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:58:47 INFO - Successfully installed psutil 22:58:47 INFO - Cleaning up... 22:58:47 INFO - Return code: 0 22:58:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:47 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:47 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 22:58:47 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 22:58:47 INFO - Using env: {'DISPLAY': ':0', 22:58:47 INFO - 'HOME': '/home/cltbld', 22:58:47 INFO - 'LANG': 'en_US.UTF-8', 22:58:47 INFO - 'LANGUAGE': 'en_US:en', 22:58:47 INFO - 'LOGNAME': 'cltbld', 22:58:47 INFO - 'MAIL': '/var/mail/cltbld', 22:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:47 INFO - 'MOZ_NO_REMOTE': '1', 22:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:47 INFO - 'NO_EM_RESTART': '1', 22:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:47 INFO - 'SHELL': '/bin/bash', 22:58:47 INFO - 'SHLVL': '1', 22:58:47 INFO - 'TERM': 'linux', 22:58:47 INFO - 'TMOUT': '86400', 22:58:47 INFO - 'USER': 'cltbld', 22:58:47 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:47 INFO - '_': '/tools/buildbot/bin/python'} 22:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:58:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:58:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:58:49 INFO - Installing collected packages: mozsystemmonitor 22:58:49 INFO - Running setup.py install for mozsystemmonitor 22:58:49 INFO - Successfully installed mozsystemmonitor 22:58:49 INFO - Cleaning up... 22:58:49 INFO - Return code: 0 22:58:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:49 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:49 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 22:58:49 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 22:58:49 INFO - Using env: {'DISPLAY': ':0', 22:58:49 INFO - 'HOME': '/home/cltbld', 22:58:49 INFO - 'LANG': 'en_US.UTF-8', 22:58:49 INFO - 'LANGUAGE': 'en_US:en', 22:58:49 INFO - 'LOGNAME': 'cltbld', 22:58:49 INFO - 'MAIL': '/var/mail/cltbld', 22:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:49 INFO - 'MOZ_NO_REMOTE': '1', 22:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:49 INFO - 'NO_EM_RESTART': '1', 22:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:49 INFO - 'SHELL': '/bin/bash', 22:58:49 INFO - 'SHLVL': '1', 22:58:49 INFO - 'TERM': 'linux', 22:58:49 INFO - 'TMOUT': '86400', 22:58:49 INFO - 'USER': 'cltbld', 22:58:49 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:49 INFO - '_': '/tools/buildbot/bin/python'} 22:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:49 INFO - Downloading/unpacking blobuploader==1.2.4 22:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:51 INFO - Downloading blobuploader-1.2.4.tar.gz 22:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:58:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:58:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:58:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:58:52 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 22:58:52 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 22:58:52 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 22:58:52 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 22:58:52 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 22:58:52 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 22:58:52 INFO - Downloading docopt-0.6.1.tar.gz 22:58:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:58:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:58:52 INFO - Installing collected packages: blobuploader, requests, docopt 22:58:52 INFO - Running setup.py install for blobuploader 22:58:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:58:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:58:52 INFO - Running setup.py install for requests 22:58:52 INFO - Running setup.py install for docopt 22:58:52 INFO - Successfully installed blobuploader requests docopt 22:58:52 INFO - Cleaning up... 22:58:52 INFO - Return code: 0 22:58:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:52 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:52 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 22:58:52 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 22:58:52 INFO - Using env: {'DISPLAY': ':0', 22:58:52 INFO - 'HOME': '/home/cltbld', 22:58:52 INFO - 'LANG': 'en_US.UTF-8', 22:58:52 INFO - 'LANGUAGE': 'en_US:en', 22:58:52 INFO - 'LOGNAME': 'cltbld', 22:58:52 INFO - 'MAIL': '/var/mail/cltbld', 22:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:52 INFO - 'MOZ_NO_REMOTE': '1', 22:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:52 INFO - 'NO_EM_RESTART': '1', 22:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:52 INFO - 'SHELL': '/bin/bash', 22:58:52 INFO - 'SHLVL': '1', 22:58:52 INFO - 'TERM': 'linux', 22:58:52 INFO - 'TMOUT': '86400', 22:58:52 INFO - 'USER': 'cltbld', 22:58:52 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:52 INFO - '_': '/tools/buildbot/bin/python'} 22:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:53 INFO - Running setup.py (path:/tmp/pip-2AzHJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:53 INFO - Running setup.py (path:/tmp/pip-qIgfjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:53 INFO - Running setup.py (path:/tmp/pip-1SoAnQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:53 INFO - Running setup.py (path:/tmp/pip-lQqL69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:53 INFO - Running setup.py (path:/tmp/pip-0QF6ey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:53 INFO - Running setup.py (path:/tmp/pip-VoxraC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:53 INFO - Running setup.py (path:/tmp/pip-wzWd8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:53 INFO - Running setup.py (path:/tmp/pip-0Pw9nU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:53 INFO - Running setup.py (path:/tmp/pip-N_jA6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:53 INFO - Running setup.py (path:/tmp/pip-jo15kB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:53 INFO - Running setup.py (path:/tmp/pip-VCFY8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:53 INFO - Running setup.py (path:/tmp/pip-DvNrB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:53 INFO - Running setup.py (path:/tmp/pip-nq3eFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:54 INFO - Running setup.py (path:/tmp/pip-sd1mzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:54 INFO - Running setup.py (path:/tmp/pip-0zfuXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:54 INFO - Running setup.py (path:/tmp/pip-l9jZYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:54 INFO - Running setup.py (path:/tmp/pip-TRjYjo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:58:54 INFO - Running setup.py install for manifestparser 22:58:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:58:54 INFO - Running setup.py install for mozcrash 22:58:54 INFO - Running setup.py install for mozdebug 22:58:54 INFO - Running setup.py install for mozdevice 22:58:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:58:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:58:54 INFO - Running setup.py install for mozfile 22:58:54 INFO - Running setup.py install for mozhttpd 22:58:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:58:54 INFO - Running setup.py install for mozinfo 22:58:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for mozInstall 22:58:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for mozleak 22:58:55 INFO - Running setup.py install for mozlog 22:58:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for moznetwork 22:58:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for mozprocess 22:58:55 INFO - Running setup.py install for mozprofile 22:58:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for mozrunner 22:58:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:58:55 INFO - Running setup.py install for mozscreenshot 22:58:55 INFO - Running setup.py install for moztest 22:58:55 INFO - Running setup.py install for mozversion 22:58:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:58:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:58:56 INFO - Cleaning up... 22:58:56 INFO - Return code: 0 22:58:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:56 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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:56 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 22:58:56 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 22:58:56 INFO - Using env: {'DISPLAY': ':0', 22:58:56 INFO - 'HOME': '/home/cltbld', 22:58:56 INFO - 'LANG': 'en_US.UTF-8', 22:58:56 INFO - 'LANGUAGE': 'en_US:en', 22:58:56 INFO - 'LOGNAME': 'cltbld', 22:58:56 INFO - 'MAIL': '/var/mail/cltbld', 22:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:56 INFO - 'MOZ_NO_REMOTE': '1', 22:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:56 INFO - 'NO_EM_RESTART': '1', 22:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:56 INFO - 'SHELL': '/bin/bash', 22:58:56 INFO - 'SHLVL': '1', 22:58:56 INFO - 'TERM': 'linux', 22:58:56 INFO - 'TMOUT': '86400', 22:58:56 INFO - 'USER': 'cltbld', 22:58:56 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:56 INFO - '_': '/tools/buildbot/bin/python'} 22:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:56 INFO - Running setup.py (path:/tmp/pip-8862lA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:56 INFO - Running setup.py (path:/tmp/pip-yqIgRp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:56 INFO - Running setup.py (path:/tmp/pip-GM9yK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:56 INFO - Running setup.py (path:/tmp/pip-vpIMf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:56 INFO - Running setup.py (path:/tmp/pip-49XHAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:56 INFO - Running setup.py (path:/tmp/pip-fMHKU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:56 INFO - Running setup.py (path:/tmp/pip-oifD5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:56 INFO - Running setup.py (path:/tmp/pip-2T1Bz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:56 INFO - Running setup.py (path:/tmp/pip-xQKOMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:58:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:56 INFO - Running setup.py (path:/tmp/pip-K51ugF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:58:57 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)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:57 INFO - Running setup.py (path:/tmp/pip-FnCllI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:58:57 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)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:57 INFO - Running setup.py (path:/tmp/pip-r2QJZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:57 INFO - Running setup.py (path:/tmp/pip-qYbXp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:57 INFO - Running setup.py (path:/tmp/pip-ZAcf5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:57 INFO - Running setup.py (path:/tmp/pip-ki3GIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:57 INFO - Running setup.py (path:/tmp/pip-8JXADo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:58:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:57 INFO - Running setup.py (path:/tmp/pip-fRe8x6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:58:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:58:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:59 INFO - Downloading blessings-1.5.1.tar.gz 22:58:59 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 22:58:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:58:59 INFO - Installing collected packages: blessings 22:58:59 INFO - Running setup.py install for blessings 22:58:59 INFO - Successfully installed blessings 22:58:59 INFO - Cleaning up... 22:58:59 INFO - Return code: 0 22:58:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:58:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:58:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:58:59 INFO - Reading from file tmpfile_stdout 22:58:59 INFO - Current package versions: 22:58:59 INFO - argparse == 1.2.1 22:58:59 INFO - blessings == 1.5.1 22:58:59 INFO - blobuploader == 1.2.4 22:58:59 INFO - docopt == 0.6.1 22:58:59 INFO - manifestparser == 1.1 22:58:59 INFO - mozInstall == 1.12 22:58:59 INFO - mozcrash == 0.16 22:58:59 INFO - mozdebug == 0.1 22:58:59 INFO - mozdevice == 0.47 22:58:59 INFO - mozfile == 1.2 22:58:59 INFO - mozhttpd == 0.7 22:58:59 INFO - mozinfo == 0.9 22:58:59 INFO - mozleak == 0.1 22:58:59 INFO - mozlog == 3.1 22:58:59 INFO - moznetwork == 0.27 22:58:59 INFO - mozprocess == 0.22 22:58:59 INFO - mozprofile == 0.28 22:58:59 INFO - mozrunner == 6.11 22:58:59 INFO - mozscreenshot == 0.1 22:58:59 INFO - mozsystemmonitor == 0.0 22:58:59 INFO - moztest == 0.7 22:58:59 INFO - mozversion == 1.4 22:58:59 INFO - psutil == 3.1.1 22:58:59 INFO - requests == 1.2.3 22:58:59 INFO - wsgiref == 0.1.2 22:58:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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', '-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 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58:59 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 22:58:59 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 22:58:59 INFO - Using env: {'DISPLAY': ':0', 22:58:59 INFO - 'HOME': '/home/cltbld', 22:58:59 INFO - 'LANG': 'en_US.UTF-8', 22:58:59 INFO - 'LANGUAGE': 'en_US:en', 22:58:59 INFO - 'LOGNAME': 'cltbld', 22:58:59 INFO - 'MAIL': '/var/mail/cltbld', 22:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:59 INFO - 'MOZ_NO_REMOTE': '1', 22:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:59 INFO - 'NO_EM_RESTART': '1', 22:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:59 INFO - 'SHELL': '/bin/bash', 22:58:59 INFO - 'SHLVL': '1', 22:58:59 INFO - 'TERM': 'linux', 22:58:59 INFO - 'TMOUT': '86400', 22:58:59 INFO - 'USER': 'cltbld', 22:58:59 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:59 INFO - '_': '/tools/buildbot/bin/python'} 22:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:58:59 INFO - Cleaning up... 22:58:59 INFO - Return code: 0 22:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:58: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')]} 22:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:58: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', 'jsonschema'] in /builds/slave/test-pgo/build 22:58: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 jsonschema 22:58:59 INFO - Using env: {'DISPLAY': ':0', 22:58:59 INFO - 'HOME': '/home/cltbld', 22:58:59 INFO - 'LANG': 'en_US.UTF-8', 22:58:59 INFO - 'LANGUAGE': 'en_US:en', 22:58:59 INFO - 'LOGNAME': 'cltbld', 22:58:59 INFO - 'MAIL': '/var/mail/cltbld', 22:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:59 INFO - 'MOZ_NO_REMOTE': '1', 22:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:58:59 INFO - 'NO_EM_RESTART': '1', 22:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:58:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:58:59 INFO - 'SHELL': '/bin/bash', 22:58:59 INFO - 'SHLVL': '1', 22:58:59 INFO - 'TERM': 'linux', 22:58:59 INFO - 'TMOUT': '86400', 22:58:59 INFO - 'USER': 'cltbld', 22:58:59 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:59 INFO - '_': '/tools/buildbot/bin/python'} 22:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:00 INFO - Downloading/unpacking jsonschema 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:59:01 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 22:59:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:59:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:59:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:59:02 INFO - warning: no files found matching '*.txt' 22:59:02 INFO - no previously-included directories found matching 'build' 22:59:02 INFO - no previously-included directories found matching 'dist' 22:59:02 INFO - no previously-included directories found matching '.git*' 22:59:02 INFO - Installing collected packages: jsonschema, functools32 22:59:02 INFO - Running setup.py install for functools32 22:59:02 INFO - warning: no files found matching '*.txt' 22:59:02 INFO - no previously-included directories found matching 'build' 22:59:02 INFO - no previously-included directories found matching 'dist' 22:59:02 INFO - no previously-included directories found matching '.git*' 22:59:02 INFO - Successfully installed jsonschema functools32 22:59:02 INFO - Cleaning up... 22:59:02 INFO - Return code: 0 22:59:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:59: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')]} 22:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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')]} 22:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67f6d29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2200630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', '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 22:59: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', 'flake8'] in /builds/slave/test-pgo/build 22:59: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 flake8 22:59:02 INFO - Using env: {'DISPLAY': ':0', 22:59:02 INFO - 'HOME': '/home/cltbld', 22:59:02 INFO - 'LANG': 'en_US.UTF-8', 22:59:02 INFO - 'LANGUAGE': 'en_US:en', 22:59:02 INFO - 'LOGNAME': 'cltbld', 22:59:02 INFO - 'MAIL': '/var/mail/cltbld', 22:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:02 INFO - 'MOZ_NO_REMOTE': '1', 22:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:02 INFO - 'NO_EM_RESTART': '1', 22:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:02 INFO - 'SHELL': '/bin/bash', 22:59:02 INFO - 'SHLVL': '1', 22:59:02 INFO - 'TERM': 'linux', 22:59:02 INFO - 'TMOUT': '86400', 22:59:02 INFO - 'USER': 'cltbld', 22:59:02 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:02 INFO - '_': '/tools/buildbot/bin/python'} 22:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:59:02 INFO - Downloading/unpacking flake8 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:59:04 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 22:59:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:59:04 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 22:59:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:04 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 22:59:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59: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 22:59:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:59:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:04 INFO - no previously-included directories found matching 'docs/_build' 22:59:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:59:04 INFO - Running setup.py install for pep8 22:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:59:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:59:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:59:04 INFO - no previously-included directories found matching 'docs/_build' 22:59:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:59:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:59:04 INFO - Cleaning up... 22:59:05 INFO - Return code: 0 22:59:05 INFO - Running post-action listener: _resource_record_post_action 22:59:05 INFO - Running post-action listener: _start_resource_monitoring 22:59:05 INFO - Starting resource monitoring. 22:59:05 INFO - ##### 22:59:05 INFO - ##### Running install step. 22:59:05 INFO - ##### 22:59:05 INFO - Running pre-action listener: _resource_record_pre_action 22:59:05 INFO - Running main action method: install 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:59:05 INFO - Reading from file tmpfile_stdout 22:59:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:59:05 INFO - Reading from file tmpfile_stdout 22:59:05 INFO - Output received: 22:59:05 INFO - Usage: mozinstall [options] installer 22:59:05 INFO - Options: 22:59:05 INFO - -h, --help show this help message and exit 22:59:05 INFO - -d DEST, --destination=DEST 22:59:05 INFO - Directory to install application into. [default: 22:59:05 INFO - "/builds/slave/test-pgo"] 22:59:05 INFO - --app=APP Application being installed. [default: firefox] 22:59:05 INFO - mkdir: /builds/slave/test-pgo/build/application 22:59:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:59:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:59:21 INFO - Reading from file tmpfile_stdout 22:59:21 INFO - Output received: 22:59:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:59:21 INFO - Running post-action listener: _resource_record_post_action 22:59:21 INFO - ##### 22:59:21 INFO - ##### Running run-tests step. 22:59:21 INFO - ##### 22:59:21 INFO - Running pre-action listener: _resource_record_pre_action 22:59:21 INFO - Running main action method: run_tests 22:59:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:59:21 INFO - Python 2.7.3 22:59:21 INFO - Return code: 0 22:59:21 INFO - grabbing minidump binary from tooltool 22:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:59:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2291840>, '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 0x21fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21feb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:59:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:59:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:59:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:59:21 INFO - Return code: 0 22:59:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:59:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:59:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:59:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:59:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:59:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:59:22 INFO - Return code: 0 22:59:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 22:59:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 22:59:22 INFO - Using env: {'DISPLAY': ':0', 22:59:22 INFO - 'HOME': '/home/cltbld', 22:59:22 INFO - 'LANG': 'en_US.UTF-8', 22:59:22 INFO - 'LANGUAGE': 'en_US:en', 22:59:22 INFO - 'LOGNAME': 'cltbld', 22:59:22 INFO - 'MAIL': '/var/mail/cltbld', 22:59:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:59:22 INFO - 'MOZ_NO_REMOTE': '1', 22:59:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:59:22 INFO - 'NO_EM_RESTART': '1', 22:59:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:59:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:59:22 INFO - 'SHELL': '/bin/bash', 22:59:22 INFO - 'SHLVL': '1', 22:59:22 INFO - 'TERM': 'linux', 22:59:22 INFO - 'TMOUT': '86400', 22:59:22 INFO - 'USER': 'cltbld', 22:59:22 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471', 22:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:59:22 INFO - '_': '/tools/buildbot/bin/python'} 22:59:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 22:59:22 INFO - mozversion application_buildid: 20151221203114 22:59:22 INFO - mozversion application_changeset: 0db21edafc584d96b7ce682145d99d7df0b643de 22:59:22 INFO - mozversion application_display_name: Nightly 22:59:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:59:22 INFO - mozversion application_name: Firefox 22:59:22 INFO - mozversion application_remotingname: firefox 22:59:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:59:22 INFO - mozversion application_vendor: Mozilla 22:59:22 INFO - mozversion application_version: 46.0a1 22:59:22 INFO - mozversion platform_buildid: 20151221203114 22:59:22 INFO - mozversion platform_changeset: 0db21edafc584d96b7ce682145d99d7df0b643de 22:59:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:59:22 INFO - mozversion platform_version: 46.0a1 22:59:22 INFO - using testdate: 1450767562 22:59:22 INFO - actual date: 1450767562 22:59:22 INFO - starting webserver on 'localhost:51490' 22:59:22 INFO - SUITE-START | Running 3 tests 22:59:22 INFO - TEST-START | dromaeo_css 22:59:22 INFO - operating with platform_type : linux_ 22:59:22 INFO - Initialising browser for dromaeo_css test... 22:59:22 INFO - TEST-INFO | started process 28067 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprzxbur/profile http://localhost:51490/getInfo.html) 22:59:26 INFO - PROCESS | 28067 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 22:59:26 INFO - PROCESS | 28067 | __metrics Screen width/height:1600/1200 22:59:26 INFO - PROCESS | 28067 | colorDepth:24 22:59:26 INFO - PROCESS | 28067 | Browser inner width/height: 1024/697 22:59:26 INFO - PROCESS | 28067 | __metrics 22:59:26 INFO - PROCESS | 28067 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:59:26 INFO - PROCESS | 28067 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:59:27 INFO - PROCESS | 28067 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:59:27 INFO - TEST-INFO | 28067: exit 0 22:59:27 INFO - Browser initialized. 22:59:27 INFO - Running cycle 1/1 for dromaeo_css test... 22:59:27 INFO - TEST-INFO | started process 28159 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprzxbur/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:39 INFO - PROCESS | 28159 | RSS: Main: 147898368 22:59:39 INFO - PROCESS | 28159 | 23:00:30 INFO - PROCESS | 28159 | 1450767630923 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] 23:02:39 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51490/tests/dromaeo/cssquery-ext.html) 23:02:40 INFO - PROCESS | 28159 | RSS: Main: 273973248 23:02:40 INFO - PROCESS | 28159 | 23:05:43 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-ext.html (next: http://localhost:51490/tests/dromaeo/cssquery-jquery.html) 23:05:43 INFO - PROCESS | 28159 | RSS: Main: 234938368 23:05:43 INFO - PROCESS | 28159 | 23:08:45 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51490/tests/dromaeo/cssquery-mootools.html) 23:08:46 INFO - PROCESS | 28159 | RSS: Main: 230326272 23:08:46 INFO - PROCESS | 28159 | 23:11:47 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51490/tests/dromaeo/cssquery-prototype.html) 23:11:48 INFO - PROCESS | 28159 | RSS: Main: 212717568 23:11:48 INFO - PROCESS | 28159 | 23:14:50 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51490/tests/dromaeo/cssquery-yui.html) 23:14:51 INFO - PROCESS | 28159 | RSS: Main: 215605248 23:14:51 INFO - PROCESS | 28159 | 23:17:53 INFO - PROCESS | 28159 | Cycle 1(1): loaded http://localhost:51490/tests/dromaeo/cssquery-yui.html (next: http://localhost:51490/tests/dromaeo/cssquery-dojo.html) 23:17:54 INFO - PROCESS | 28159 | RSS: Main: 261947392 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | __start_tp_report 23:17:54 INFO - PROCESS | 28159 | _x_x_mozilla_page_load 23:17:54 INFO - PROCESS | 28159 | _x_x_mozilla_page_load_details 23:17:54 INFO - PROCESS | 28159 | |i|pagename|runs| 23:17:54 INFO - PROCESS | 28159 | |0;dojo.html;3109.082820567933;3152.3222507160954;3202.8558714857845;3208.1819136120303;3211;5139.434662187156;5232.398274198468;5239.476052394759;5258.474152584739;5323.174907889278;5180.792768289264;5209.661372010826;5231.712255825928;5235.79056837727;5290.894182116355;4810.254410566359;4819.638527110464;4831.985283090556;4892.608591312686;4924.630652701044;4708.952910470903;4911.410630724318;4928.186849169882;4941.258811178316;5000.624953128512;4722.527747225285;4785.832495862628;4801.759912004386;4801.951980480186;4813.711177329354;4809.663323567352;4816.710997340171;4817.879553011167;4822.63830212732;4857.611391088704;4681.88295292617;4782.760861956888;4806.495317991596;4814.518548145193;4863.537963893425;5135.563477104451;5163;5254.21186821976;5265.262863199156;5280.762365693553;5680.801171959003;5691.630044047124;5691.9146212806845;5692.430756924316;5693.259876216065;5481.725913704299;5603.159526071081;5667.574931880125;5668.149777533362;5670.801521946753;5242.842714718565;5257;5261.105612045962;5272.077386457393;5280.894382112375;5779.88440231193;5787.797427090031;5791.971040144772;5792.275965504312;5795.768169273266;5442.12925931849;5527.115661494222;5607.80372686954;5611.298587676541;5612;5565.610407271533;5569.916451253234;5631.380548139701;5642.943570564324;5691.68695721731;5558.610897237236;5585.1901474286005;5597.076482380362;5598.272224610774;5598.804041858515;5486.561075113981;5591.9720401398545;5607.102863541895;5612.663240205601;5613.270274864241;4365.672574556921;4428.490723566831;4433.246348120827;4465.285554311359;4475.462944446687;3927.3912543555793;3945.684345252373;3948.072203032285;3962.7622342659533;3990.8004599769897;5190.662606930538;5280.498352656491;5289;5353.2237825515085;5421.5391691706645;5526.972365138148;5561.193626924073;5604.747786349624;5630.296212973379;5640.012997725382;5338.279332290169;5339.706316152571;5341.145416733381;5341.839744807662;5342.572594192533;4891.290762839369;4964.950350496449;4973.875653108629;5002.274670172877;5016.598672106223;5761;5834.795782147689;5837.211976383219;5841.06542953134;5882;5756.107803290497;5764.855878603068;5786.94213057864;5787.6816775076095;5787.6816775076095;5761;5841;5866.911996320144;5894.086416605433;5906.143609176731;5535.474129957647;5571.8885622288135;5587.8882422352135;5590.608657393944;5612.242347283064;5672.546196304368;5701.4298570142655;5706.3152421709665;5707.372189059117;5735.7418916148035;5311.123664595299;5441.863953401038;5578.135389014709;5586.1062230043;5597.63615365;5480.835574932758;5537.7784888604;5539.196816461671;5541.141123125922;5585.106382978866;5450.563954883521;5474.616776825584;5477.643953143033;5478.863028424162;5479.2602998594675;5398.811041613525;5405.216243644571;5500.862478438071;5580.707293342064;5634.4365563443325;5348.679079255257;5405.567554595702;5414.648047876875;5416.729163541886;5462.20797984298 23:17:54 INFO - PROCESS | 28159 | |1;ext.html;545.52603941127;588.9234399528062;607.5777334752347;612.3019757476475;616.3805375597524;29193.56209656854;29935.1019469416;37663.24673506528;38469.42295865564;38589.61410385902;43128.568714312845;43454.34818477726;43636.345454818205;43654.563454365445;43661;7628.427867909902;7751.728689495869;8796.999999999984;8965.686200982967;8976.461412315282;10188.032136946978;10349.120324772404;10398.272120951537;10421.114205292559;10468.633597824077;10175.542100605453;10190.439525826077;10220.591176352937;10273.794524109513;10291.742706432324;7854;8062.677492900277;10224.74438139045;10565.894341056568;10835.404052777094;10353.896461035369;10489.737756556071;10493.475326233658;10493.63272285474;10497.160227181806;40611.390829137585;40639.18721625581;40879.1824163518;40929.79535102335;41036.58963410358;3265.6571060038827;3286.260591366947;3435.7766745161484;3493.982530087333;3788.488554045196;29700.851495742383;30036.399272014656;30145.698543014507;30366.240843978856;30442.54336184959;3881.243157584272;4042.333015052513;4053.412255222976;4067;4084.7344922580232;262655;265569;265885;266334;266747;52522.73738631359;53438.7328063365;59915;60157.69921150366;60192.699036505415;70456.64771676109;70530.53633563903;70924.29075709281;70930;71005.2899471009;15683.764743528856;15856.52430427089;15946.681066378607;15991.440299589458;16006.679866402606;11892.524299028115;12034;12057.577984770667;12079.57721479744;12124.575639852563;19933.700994485094;20073.598528029357;20161.39515814528;20238.898805506175;20389.694154587694;7736.381089512825;7851.291304499939;7889.605519723991;7900.84198316042;7985.880211796828;888.9422187557788;891.433939448442;1035.2132379391567;1046.35126221743;1079.9892001079888;27653;27748.306292342448;27943.58084628732;28317.57523637147;28373.574396384072;1002.173207104142;1057.3127467146417;1075;1096.9670909872716;1148.4774427635407;13829.446822127002;13950.23273719955;14034.719305613831;14073.85926140746;14137.78793318101;371102;375480;375524;375855;376688;50736.49263507391;51128;51161.74419127955;51234.23148652773;51659.22511162335;1199.7300607363447;1250.8123781432857;1268.7716211081909;1271.0086132816418;1371.8902487801151;26948.461030778883;27545.862270688518;27936;28009.299767505974;28160;40659;41022.38466422947;41373.79313103415;41426.37860432036;41428.79285603553;176748;370347;371965;373482;374173;28745.281367965967;29359.853200734713;29462.852685736434;29508.262293442836;29536.113916582537;40979.38530921979;41841.58158418498;41884.16231675288;42033;42707.3593896098;35155.472667910515;35245.47131792974;35421.46867797037;35442.8227858859;36159.819200903825;34879;35448.46827297644;35492.46761298531;35564.466533002545;35627;35218.82390588031;35469.82265088658;39736.2052758949;40827.7958610205;40999.38500922548;30423.84788076134;32148.678513214567;32208.516872246466;32494.51258231081;32686.509702354007;24616;24743.38141546476;24857;25185.87407062953;25248.242552723448 23:17:54 INFO - PROCESS | 28159 | |2;jquery.html;332.54109329125794;337.2395248714149;337.6808915574781;337.8344611140542;343.4007656639165;14433.711325773504;14738.484153054618;16182.75725864113;16295.918520407396;18431.90784046081;14353.712925741505;14427.27863606818;15944.20278986049;15993.200339982983;16520;5148.459411761758;5276.736163191844;5295.179247216668;5297.205419187134;5298.576113910897;3783.2244389900143;3877.3214687429727;5190.948090519084;5248.0553500369915;5287.021900948318;5433.994710978462;5541.639793413416;5545.223668686387;5583.246261754672;5583.553315734732;5455.672659640434;5546.112621980484;5547.195656629786;6032.939670603281;6041.818745437644;5359.383670877821;5378.489043540857;5380.300560927094;5381.730913454312;5382.869597384554;12420.81368779469;12932.676683082904;13444;13451.260180690058;13488.258145802076;2143.506993391513;2153.6554151335868;2192.254633424627;2296.127471560796;2303.7235531736133;9617.759556011086;9801.460919649417;9855.310128291023;9964.402135871871;9982.051705088077;1805.2688661092147;1809.11353436815;1859.9907000465046;1861.153175305233;1877.4180004198743;58387.41612583862;62116.37883621197;62311.37688623101;62322.37677623211;62938.05592916064;9961.55173017216;10220.131288840532;10349.689509314732;10363.274570779973;10431.113355364727;13644.249566273751;13668;13729.382177802023;13766.31168441574;13767.105138165987;7272.163701174327;7312.926870731225;7314.232005639437;7497.66260518278;7689.307962283421;6867.3476019778045;6974.16310042788;6999.440044796404;7079.327463890922;7081.92918070823;4354.804033818486;4420.535843736361;4421.867343979686;4426.734395936254;4448.310511870665;1712.5033740215447;1724.922378492971;1815.9001254931106;1840.3282801777523;1855.2022630268843;870.8650159225331;891.2424439226735;990.2325697584286;1031.5254982707888;1053.752368193474;15651.295691693902;16259.001428243328;17052.744208836877;17239;17433.21550530204;933.5612262236738;942.1332374215738;963.2390411574918;964.2334344196381;975.7267964969819;9567.282453815991;9814.411135331902;9912.653057142965;9948.701538953843;10259.230557708202;504339;548517;553616;553839;554393;70421.6478917602;79973;81612.59193703994;82822;85497;1165.3241120150292;1177.0642339340245;1184.3249347871804;1189.756099999498;1198.2151690642818;15148.697026059197;15554.589038698567;15633.280339162911;15666.530004099895;15966.281517331516;35003.82498087595;35229.647703522634;35642.10894727652;35644.643553564136;36102.63897361098;47383.289250661954;47612;48912.51087489222;49933.75033124811;50945;9635.13283804461;9680.27397945143;9827.52587111939;9828.852567211354;9835.311528192959;16616.91691541583;17229.22468488946;17511.82488175102;17698.734518982485;17814.376496822548;11556.88443115558;12049.277043377426;13876;14069.577912662637;14073.648158796112;13318.933405332911;13430.030888571291;13478.32608369558;13869.861301386856;13889.166650001032;13868.167909925436;13874.722505550035;14108;14625.85374146245;15071.397144114551;9776.608935642495;9814.950925245328;9895.109440150422;9897.802043959224;9902.702918912444;13618.455261789417;13849.930750346184;13976.231307278198;14639.560813175622;14649.340779664728 23:17:54 INFO - PROCESS | 28159 | |3;mootools.html;1327.4623777370168;1645.292524214588;1654.2225154177534;1668.0325411261476;1720.898624880077;6787.389134977851;7506.774796756093;7696.692132314701;7712.652930618122;7717.112532058822;7557.735479258227;7644.885326720104;7652.846943061136;7674.961625191866;7696.615169241543;1933.82595566399;1966.7443232379842;1966.9704954425695;2256.8758718270446;2309.1225334372916;2001.0495014867968;2281.7832305930992;2320.9419764505856;2324.337563794319;2325.965110523335;2240.8431409801237;2248.291788086756;2256.9661455078185;2258.762829902861;2300.3903965449085;2262.9434264143365;2263.287064574654;2284.463151159476;2284.828637852168;2286.5198308355184;2282.3837563857664;2303.170858490942;2303.3550605830396;2304.4699719064542;2306.573283942459;7607.125180604246;7696.615169241515;7697;7699.461037727361;7709.537427754352;4646.163690535702;4712.787924543404;4717.882052948669;4734.928976065362;4746.121967436035;3067.9233019174476;3107.9533806992913;3112.3464072544793;3127.9687203128133;3139.2779660677943;998.8102260570469;1003.9247056470793;1015.3653966271081;1027.5222021759917;1052.9262951593391;10289.794204115951;10357.896421035844;10388.948055259676;10402.843957340647;10442.791144177074;4176.352665336817;4183.958160418418;4231.640310573574;4240.872773816729;4271.508776490681;9066.682666106655;9095.31785116119;9126.08739126082;9126.81746365069;9132.543372831331;4537.205988951986;4560.566746159109;4578.267477203632;4584.4957054723955;4590.219662657356;4157.168566286755;4172.08214192877;4199.4330765346895;4200.789960501963;4211.831526738957;3296.225387034045;3675.448682697563;3679.7608155469807;3688.7233457490797;3741.9064523387133;1094.7372630568607;1112.67732357617;1175.9823602645968;1181.2203945395997;1186.602488166474;1057.1965306367063;1058.2697938422464;1061.4480470155477;1194.7132688154954;1320.7886738121854;7283.126024877049;7329.780106596811;7384.52000619958;7384.556926584422;7396.112466504054;1100.8018556659717;1116.553378648547;1133.3766428464312;1143.6226045404997;1156.9652910412701;5710.942890571124;5840.737166827503;5865.853353666193;5870.119482077637;5885.911711324334;8822.691205807765;8944.955275223712;9007.684731034382;9080.137386948229;9152.450852948845;9085.318601104944;9094.727158185266;9165.220956218664;9201.585928633094;9204.4477331359;6968.268331825187;7224.241454647292;7249.565026098451;7300.306470885257;7315;7226.060612120391;7269.600171990592;7279.672414741243;7280.0535930328715;7285.7814265572115;8073.919260807552;8160.83678326442;8238.711645092393;8353.24820766134;8368.874466883124;8401.327893768606;8497.065322814362;8626.78433039179;8629.39594228398;8649.351298652751;6474.093626892145;6630;6770.424513916372;6843.349881761224;6849.794506164823;6668.899966500409;6763.628000460022;7413.740519081806;7443.069616297963;7452.180260171485;6663.267040625624;6793.796186114425;6811.727530898708;6851.828704282433;7025.508214424941;6637.369449902251;6809.399791049001;6864.897026544506;6920.550164239308;6985.545939513915;6804.251532331341;6840.179178498612;6840.3501667341525;6841.213260475109;6856.897146542706;6275.529335299962;6316.936830631635;6318.27339855904;6324.778632747832;6338.809835704937;6488.9026664601015;6583.3087525811015;6602.570832895846;6602.900956485752;6605.207375115017 23:17:54 INFO - PROCESS | 28159 | |4;prototype.html;322.2636276109091;329.4843569813242;330.04616657858776;332.61250643000903;335.0234067692676;5973.074173503103;6035.607685500445;6038.728257228424;6039.72821223045;6044.335123136451;5717.742701578429;5777.19119323295;5849.239598852143;5968.79109231177;5982.162497250389;4567.1550763108935;4586.289125185584;4589.954100458986;4593.655475839309;4601.608863246628;4589.632829373642;4595.839145629903;4596.6322694184555;4599.218132917412;4601.171789077965;4368.322909948947;4462.642988560908;4464.46426428829;4575.977120114395;4592.012717265788;4558;4560.589546940775;4564.8174073037035;4576.656750743691;4593.219152744042;4033.052232725307;4059.9594004059877;4061.2892743770017;4064.9390259146135;4067.5525692174133;5639.464250896158;5662.518685911702;5663.773449062032;5669.177969194444;5670.121131224667;5123.1546794778815;5265.7893684252585;5267.157254839208;5293.385517417186;5322.866928326823;6332.841678958017;6336.429721325057;6338.936610633881;6341.207349081365;6344.238691357021;4424.159409712144;4425.137098265839;4427.424434823452;4429.911401771947;4430.047539778963;6443.613383197023;6503.414692677635;6585.242697089848;6592.373724496165;6600.405963463311;4432.578905004019;4433.889152771142;4436.933445998313;4438.556144385536;4438.755868427203;4477.1493416250805;4479.664025198123;4483.955160448354;4488.820447182076;4492.797824097924;5227.790888364499;5230.97384513075;5238.1618940969265;5242.868928276747;5248.475152484797;6285.874282514415;6397.232332120082;6400.871982560323;6403.96798016007;6407.070974708641;1561.8203906550664;1572.9932842980502;1575.22026596833;1575.487966410921;1576.1646327446472;1035.803197392493;1042.8227201375785;1042.9165666746642;1050.2805578178973;1061.0397590180899;6069.908951365733;6073.362296958756;6078.392160783975;6086.452219300284;6088.573799834057;6553.180852393451;6576.901346479806;6585.539012269191;6587.209534855848;6594.7032383542855;5914.9112763308585;5941.22764040672;6061.666608336495;6079;6111.8472038198515;3548.485469606944;3566.625504322061;3569.303985722811;3570.6786389225094;3572.303400836864;6754.864902701918;6758.222804377461;6765.42493888025;6771.119754431991;6803.829904252433;6551.181102362205;6774.085498457645;6782.457403407716;6789.592624442451;6790.490713196431;6750;6789.083473730983;6797.796066118024;6801.1158549388265;6804.693788779517;6577.80266592003;6613.974833900753;6624.503162262946;6638.20341559016;6638.668066596748;6340.556161068866;6531.542792004514;6540.280569137486;6546.8363290918105;6550.312217217123;6765.627890466071;6781.6948237330425;6787.253402125663;6793.966030169818;6796.218434880052;4419.535948725466;4441.156180325728;4447.755373454491;4449.911001780011;4461.888452788707;6405.967970160119;6613.867722645424;6620;6641.26946035926;6641.933580664131;6452.548321617442;6469.061986011908;6473.2232132144445;6479.967600162157;6480.837979050561;6449.903251451138;6450.193725784277;6456.870862582816;6463.321351258238;6466.741330346922;6170.3212646607935;6322.114903913548;6332.905006424815;6343.238811342669;6346.111544383883;6436.098946147449;6439.581427207217;6440.935590644221;6445.677716114082;6453.741190583259;6189.195404597373;6331.3352098029045;6337.904931426125;6338.714757835816;6344.68276586178 23:17:54 INFO - PROCESS | 28159 | |5;yui.html;683.5659356308744;693.8230751158454;747.8242612985944;747.9626018699065;757.1633345153605;13421.463141474342;13663.453461861514;13678.931605341972;13681.589552313446;13685.72628547431;12798.616041518746;14519.346629401676;14728;14769;14800;706.8974998625197;711.2212127720138;831.4803247970019;835.0271933197818;850.5662112322728;842.595554134013;846.3525403066628;850.1116333431548;850.4429598612918;851.6125163050827;888.205056474455;893.0667452512108;894.4812009034777;894.8612964990405;894.8881389826272;723.7683941138838;732.8534293141366;873.1443185678007;882.832261870249;884.8009197930478;653.1998302079961;653.4837478392064;653.8071268975664;653.8430776613626;654.0908137688616;12873.420696068699;13063.934680326633;13133.60599182026;13154.144980576328;13166.078374513789;11297.435128243555;11408.771824563546;11650.610593537578;11666.125040621988;12682.112252142353;9411.952940235324;9423.90576094237;9480.668176613854;9569.234461243084;9661.806763864683;3332.1169889979174;3392.508086327469;3392.6607339266125;3411.4371128763723;3426.7258619310396;47394.526054739355;48013;48135.75932120352;48262;48264.517354826356;9249.398789078688;9274.999999999865;9351.812963740687;9391.671291504765;9449.858252126223;18755.812441875678;18941.905290473736;18964.336248231244;18966.051697415074;19144.138513766913;6839.487038472134;6864.965675171592;6872.450203983669;6894;7022.859542809115;3912.080661044652;3953.6244056814558;3972.483577134954;4005.91988160241;4030.9395359069636;2922.7515661168613;2955.453241150351;2956.926076848096;2958.156925276286;2962.555616657519;557.8103444828778;581.221163640715;586.920765696634;588.7968650815462;591.7869566955892;548.3858078951599;631.4884943196026;633.8510450044236;645.9806205813833;666.7899611622323;7907.604619768988;7954.721584744506;8084.919150808534;8142.47073940192;8286.70996515119;641.4771960851891;654.7479220500046;661.4344735251387;678.3149019490351;682.436989483678;3594.946075808865;3857.3442514772555;3908.3746600543777;3946.940795888064;3992.9815517908364;54123.18815217696;54231.186532202046;54691;54961.450385496435;55200.17199742007;47678.28482572764;47732.7613361931;47803;47895;48577.38514841155;44058;44248.55751442509;44850.32724509135;44863.10273794571;45064.324035140155;7632.542047477169;7652.719623459795;7846.450748447553;7943.602819858868;8053.6778528858185;34309.82845085759;34514.654853451146;34588.30823383568;35148.12129696778;35604.46593301155;42956.35565466583;43564.12871742484;43814.78092609517;44132.779336103114;44221.33667995047;10002.749931251486;10068.144207742424;10076.848847267443;10142.89857101449;10243;10279.229057820843;10290.434026128634;10313;10593.576256949636;10696.358218506915;9709.271804614824;9739.464329461947;9750.853737193806;9834.803303934024;9940.602375904882;9977.900220997697;9981.900180998387;10137.290389672653;10189.286749927434;10320.535575898952;9330.346875718635;9433.858492122761;9496.382735122195;9564.713058608253;9857.556409961713;8108.040987229994;8221.17788221173;8274.931941357128;8504.319654427754;8635.438696484709;8003.599820009093;8054.597270136587;8109.7161599343735;8203.876941845758;8414.915850841413 23:17:54 INFO - PROCESS | 28159 | __end_tp_report 23:17:54 INFO - PROCESS | 28159 | __start_cc_report 23:17:54 INFO - PROCESS | 28159 | _x_x_mozilla_cycle_collect,971 23:17:54 INFO - PROCESS | 28159 | __end_cc_report 23:17:54 INFO - PROCESS | 28159 | __startTimestamp1450768674073__endTimestamp 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | ------- Summary: start ------- 23:17:54 INFO - PROCESS | 28159 | Number of tests: 6 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#0] dojo.html Cycles:165 Average:5257.57 Median:5441.86 stddev:565.21 (10.4%) stddev-sans-first:541.23 23:17:54 INFO - PROCESS | 28159 | Values: 3109.1 3152.3 3202.9 3208.2 3211.0 5139.4 5232.4 5239.5 5258.5 5323.2 5180.8 5209.7 5231.7 5235.8 5290.9 4810.3 4819.6 4832.0 4892.6 4924.6 4709.0 4911.4 4928.2 4941.3 5000.6 4722.5 4785.8 4801.8 4802.0 4813.7 4809.7 4816.7 4817.9 4822.6 4857.6 4681.9 4782.8 4806.5 4814.5 4863.5 5135.6 5163.0 5254.2 5265.3 5280.8 5680.8 5691.6 5691.9 5692.4 5693.3 5481.7 5603.2 5667.6 5668.1 5670.8 5242.8 5257.0 5261.1 5272.1 5280.9 5779.9 5787.8 5792.0 5792.3 5795.8 5442.1 5527.1 5607.8 5611.3 5612.0 5565.6 5569.9 5631.4 5642.9 5691.7 5558.6 5585.2 5597.1 5598.3 5598.8 5486.6 5592.0 5607.1 5612.7 5613.3 4365.7 4428.5 4433.2 4465.3 4475.5 3927.4 3945.7 3948.1 3962.8 3990.8 5190.7 5280.5 5289.0 5353.2 5421.5 5527.0 5561.2 5604.7 5630.3 5640.0 5338.3 5339.7 5341.1 5341.8 5342.6 4891.3 4965.0 4973.9 5002.3 5016.6 5761.0 5834.8 5837.2 5841.1 5882.0 5756.1 5764.9 5786.9 5787.7 5787.7 5761.0 5841.0 5866.9 5894.1 5906.1 5535.5 5571.9 5587.9 5590.6 5612.2 5672.5 5701.4 5706.3 5707.4 5735.7 5311.1 5441.9 5578.1 5586.1 5597.6 5480.8 5537.8 5539.2 5541.1 5585.1 5450.6 5474.6 5477.6 5478.9 5479.3 5398.8 5405.2 5500.9 5580.7 5634.4 5348.7 5405.6 5414.6 5416.7 5462.2 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#1] ext.html Cycles:180 Average:49080.60 Median:3361.02 stddev:87047.17 (2589.9%) stddev-sans-first:87215.08 23:17:54 INFO - PROCESS | 28159 | Values: 545.5 588.9 607.6 612.3 616.4 29193.6 29935.1 37663.2 38469.4 38589.6 43128.6 43454.3 43636.3 43654.6 43661.0 7628.4 7751.7 8797.0 8965.7 8976.5 10188.0 10349.1 10398.3 10421.1 10468.6 10175.5 10190.4 10220.6 10273.8 10291.7 7854.0 8062.7 10224.7 10565.9 10835.4 10353.9 10489.7 10493.5 10493.6 10497.2 40611.4 40639.2 40879.2 40929.8 41036.6 3265.7 3286.3 3435.8 3494.0 3788.5 29700.9 30036.4 30145.7 30366.2 30442.5 3881.2 4042.3 4053.4 4067.0 4084.7 262655.0 265569.0 265885.0 266334.0 266747.0 52522.7 53438.7 59915.0 60157.7 60192.7 70456.6 70530.5 70924.3 70930.0 71005.3 15683.8 15856.5 15946.7 15991.4 16006.7 11892.5 12034.0 12057.6 12079.6 12124.6 19933.7 20073.6 20161.4 20238.9 20389.7 7736.4 7851.3 7889.6 7900.8 7985.9 888.9 891.4 1035.2 1046.4 1080.0 27653.0 27748.3 27943.6 28317.6 28373.6 1002.2 1057.3 1075.0 1097.0 1148.5 13829.4 13950.2 14034.7 14073.9 14137.8 371102.0 375480.0 375524.0 375855.0 376688.0 50736.5 51128.0 51161.7 51234.2 51659.2 1199.7 1250.8 1268.8 1271.0 1371.9 26948.5 27545.9 27936.0 28009.3 28160.0 40659.0 41022.4 41373.8 41426.4 41428.8 176748.0 370347.0 371965.0 373482.0 374173.0 28745.3 29359.9 29462.9 29508.3 29536.1 40979.4 41841.6 41884.2 42033.0 42707.4 35155.5 35245.5 35421.5 35442.8 36159.8 34879.0 35448.5 35492.5 35564.5 35627.0 35218.8 35469.8 39736.2 40827.8 40999.4 30423.8 32148.7 32208.5 32494.5 32686.5 24616.0 24743.4 24857.0 25185.9 25248.2 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#2] jquery.html Cycles:180 Average:28795.50 Median:35873.64 stddev:88820.67 (247.6%) stddev-sans-first:89044.12 23:17:54 INFO - PROCESS | 28159 | Values: 332.5 337.2 337.7 337.8 343.4 14433.7 14738.5 16182.8 16295.9 18431.9 14353.7 14427.3 15944.2 15993.2 16520.0 5148.5 5276.7 5295.2 5297.2 5298.6 3783.2 3877.3 5190.9 5248.1 5287.0 5434.0 5541.6 5545.2 5583.2 5583.6 5455.7 5546.1 5547.2 6032.9 6041.8 5359.4 5378.5 5380.3 5381.7 5382.9 12420.8 12932.7 13444.0 13451.3 13488.3 2143.5 2153.7 2192.3 2296.1 2303.7 9617.8 9801.5 9855.3 9964.4 9982.1 1805.3 1809.1 1860.0 1861.2 1877.4 58387.4 62116.4 62311.4 62322.4 62938.1 9961.6 10220.1 10349.7 10363.3 10431.1 13644.2 13668.0 13729.4 13766.3 13767.1 7272.2 7312.9 7314.2 7497.7 7689.3 6867.3 6974.2 6999.4 7079.3 7081.9 4354.8 4420.5 4421.9 4426.7 4448.3 1712.5 1724.9 1815.9 1840.3 1855.2 870.9 891.2 990.2 1031.5 1053.8 15651.3 16259.0 17052.7 17239.0 17433.2 933.6 942.1 963.2 964.2 975.7 9567.3 9814.4 9912.7 9948.7 10259.2 504339.0 548517.0 553616.0 553839.0 554393.0 70421.6 79973.0 81612.6 82822.0 85497.0 1165.3 1177.1 1184.3 1189.8 1198.2 15148.7 15554.6 15633.3 15666.5 15966.3 35003.8 35229.6 35642.1 35644.6 36102.6 47383.3 47612.0 48912.5 49933.8 50945.0 9635.1 9680.3 9827.5 9828.9 9835.3 16616.9 17229.2 17511.8 17698.7 17814.4 11556.9 12049.3 13876.0 14069.6 14073.6 13318.9 13430.0 13478.3 13869.9 13889.2 13868.2 13874.7 14108.0 14625.9 15071.4 9776.6 9815.0 9895.1 9897.8 9902.7 13618.5 13849.9 13976.2 14639.6 14649.3 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#3] mootools.html Cycles:180 Average:5383.81 Median:6317.61 stddev:2762.79 (43.7%) stddev-sans-first:2753.71 23:17:54 INFO - PROCESS | 28159 | Values: 1327.5 1645.3 1654.2 1668.0 1720.9 6787.4 7506.8 7696.7 7712.7 7717.1 7557.7 7644.9 7652.8 7675.0 7696.6 1933.8 1966.7 1967.0 2256.9 2309.1 2001.0 2281.8 2320.9 2324.3 2326.0 2240.8 2248.3 2257.0 2258.8 2300.4 2262.9 2263.3 2284.5 2284.8 2286.5 2282.4 2303.2 2303.4 2304.5 2306.6 7607.1 7696.6 7697.0 7699.5 7709.5 4646.2 4712.8 4717.9 4734.9 4746.1 3067.9 3108.0 3112.3 3128.0 3139.3 998.8 1003.9 1015.4 1027.5 1052.9 10289.8 10357.9 10388.9 10402.8 10442.8 4176.4 4184.0 4231.6 4240.9 4271.5 9066.7 9095.3 9126.1 9126.8 9132.5 4537.2 4560.6 4578.3 4584.5 4590.2 4157.2 4172.1 4199.4 4200.8 4211.8 3296.2 3675.4 3679.8 3688.7 3741.9 1094.7 1112.7 1176.0 1181.2 1186.6 1057.2 1058.3 1061.4 1194.7 1320.8 7283.1 7329.8 7384.5 7384.6 7396.1 1100.8 1116.6 1133.4 1143.6 1157.0 5710.9 5840.7 5865.9 5870.1 5885.9 8822.7 8945.0 9007.7 9080.1 9152.5 9085.3 9094.7 9165.2 9201.6 9204.4 6968.3 7224.2 7249.6 7300.3 7315.0 7226.1 7269.6 7279.7 7280.1 7285.8 8073.9 8160.8 8238.7 8353.2 8368.9 8401.3 8497.1 8626.8 8629.4 8649.4 6474.1 6630.0 6770.4 6843.3 6849.8 6668.9 6763.6 7413.7 7443.1 7452.2 6663.3 6793.8 6811.7 6851.8 7025.5 6637.4 6809.4 6864.9 6920.6 6985.5 6804.3 6840.2 6840.4 6841.2 6856.9 6275.5 6316.9 6318.3 6324.8 6338.8 6488.9 6583.3 6602.6 6602.9 6605.2 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#4] prototype.html Cycles:180 Average:5315.64 Median:6042.03 stddev:1615.68 (26.7%) stddev-sans-first:1576.15 23:17:54 INFO - PROCESS | 28159 | Values: 322.3 329.5 330.0 332.6 335.0 5973.1 6035.6 6038.7 6039.7 6044.3 5717.7 5777.2 5849.2 5968.8 5982.2 4567.2 4586.3 4590.0 4593.7 4601.6 4589.6 4595.8 4596.6 4599.2 4601.2 4368.3 4462.6 4464.5 4576.0 4592.0 4558.0 4560.6 4564.8 4576.7 4593.2 4033.1 4060.0 4061.3 4064.9 4067.6 5639.5 5662.5 5663.8 5669.2 5670.1 5123.2 5265.8 5267.2 5293.4 5322.9 6332.8 6336.4 6338.9 6341.2 6344.2 4424.2 4425.1 4427.4 4429.9 4430.0 6443.6 6503.4 6585.2 6592.4 6600.4 4432.6 4433.9 4436.9 4438.6 4438.8 4477.1 4479.7 4484.0 4488.8 4492.8 5227.8 5231.0 5238.2 5242.9 5248.5 6285.9 6397.2 6400.9 6404.0 6407.1 1561.8 1573.0 1575.2 1575.5 1576.2 1035.8 1042.8 1042.9 1050.3 1061.0 6069.9 6073.4 6078.4 6086.5 6088.6 6553.2 6576.9 6585.5 6587.2 6594.7 5914.9 5941.2 6061.7 6079.0 6111.8 3548.5 3566.6 3569.3 3570.7 3572.3 6754.9 6758.2 6765.4 6771.1 6803.8 6551.2 6774.1 6782.5 6789.6 6790.5 6750.0 6789.1 6797.8 6801.1 6804.7 6577.8 6614.0 6624.5 6638.2 6638.7 6340.6 6531.5 6540.3 6546.8 6550.3 6765.6 6781.7 6787.3 6794.0 6796.2 4419.5 4441.2 4447.8 4449.9 4461.9 6406.0 6613.9 6620.0 6641.3 6641.9 6452.5 6469.1 6473.2 6480.0 6480.8 6449.9 6450.2 6456.9 6463.3 6466.7 6170.3 6322.1 6332.9 6343.2 6346.1 6436.1 6439.6 6440.9 6445.7 6453.7 6189.2 6331.3 6337.9 6338.7 6344.7 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - PROCESS | 28159 | [#5] yui.html Cycles:180 Average:13178.66 Median:584.07 stddev:15462.09 (2647.3%) stddev-sans-first:15477.00 23:17:54 INFO - PROCESS | 28159 | Values: 683.6 693.8 747.8 748.0 757.2 13421.5 13663.5 13678.9 13681.6 13685.7 12798.6 14519.3 14728.0 14769.0 14800.0 706.9 711.2 831.5 835.0 850.6 842.6 846.4 850.1 850.4 851.6 888.2 893.1 894.5 894.9 894.9 723.8 732.9 873.1 882.8 884.8 653.2 653.5 653.8 653.8 654.1 12873.4 13063.9 13133.6 13154.1 13166.1 11297.4 11408.8 11650.6 11666.1 12682.1 9412.0 9423.9 9480.7 9569.2 9661.8 3332.1 3392.5 3392.7 3411.4 3426.7 47394.5 48013.0 48135.8 48262.0 48264.5 9249.4 9275.0 9351.8 9391.7 9449.9 18755.8 18941.9 18964.3 18966.1 19144.1 6839.5 6865.0 6872.5 6894.0 7022.9 3912.1 3953.6 3972.5 4005.9 4030.9 2922.8 2955.5 2956.9 2958.2 2962.6 557.8 581.2 586.9 588.8 591.8 548.4 631.5 633.9 646.0 666.8 7907.6 7954.7 8084.9 8142.5 8286.7 641.5 654.7 661.4 678.3 682.4 3594.9 3857.3 3908.4 3946.9 3993.0 54123.2 54231.2 54691.0 54961.5 55200.2 47678.3 47732.8 47803.0 47895.0 48577.4 44058.0 44248.6 44850.3 44863.1 45064.3 7632.5 7652.7 7846.5 7943.6 8053.7 34309.8 34514.7 34588.3 35148.1 35604.5 42956.4 43564.1 43814.8 44132.8 44221.3 10002.7 10068.1 10076.8 10142.9 10243.0 10279.2 10290.4 10313.0 10593.6 10696.4 9709.3 9739.5 9750.9 9834.8 9940.6 9977.9 9981.9 10137.3 10189.3 10320.5 9330.3 9433.9 9496.4 9564.7 9857.6 8108.0 8221.2 8274.9 8504.3 8635.4 8003.6 8054.6 8109.7 8203.9 8414.9 23:17:54 INFO - PROCESS | 28159 | -------- Summary: end -------- 23:17:54 INFO - PROCESS | 28159 | 23:17:54 INFO - TEST-INFO | 28159: exit 0 23:17:54 INFO - TEST-OK | dromaeo_css | took 1112365ms 23:17:54 INFO - TEST-START | kraken 23:17:54 INFO - operating with platform_type : linux_ 23:17:54 INFO - Initialising browser for kraken test... 23:17:54 INFO - TEST-INFO | started process 28352 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTW9Lp5/profile http://localhost:51490/getInfo.html) 23:17:58 INFO - PROCESS | 28352 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 23:17:58 INFO - PROCESS | 28352 | __metrics Screen width/height:1600/1200 23:17:58 INFO - PROCESS | 28352 | colorDepth:24 23:17:58 INFO - PROCESS | 28352 | Browser inner width/height: 1024/697 23:17:58 INFO - PROCESS | 28352 | __metrics 23:17:58 INFO - PROCESS | 28352 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:17:58 INFO - PROCESS | 28352 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:17:58 ERROR - PROCESS | 28352 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 23:17:59 INFO - TEST-INFO | 28352: exit 0 23:17:59 INFO - Browser initialized. 23:17:59 INFO - Running cycle 1/1 for kraken test... 23:17:59 INFO - TEST-INFO | started process 28436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTW9Lp5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:18:11 INFO - PROCESS | 28436 | RSS: Main: 149254144 23:18:11 INFO - PROCESS | 28436 | 23:18:13 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-beat-detection) 23:18:14 INFO - PROCESS | 28436 | RSS: Main: 186187776 23:18:14 INFO - PROCESS | 28436 | 23:18:17 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-dft) 23:18:17 INFO - PROCESS | 28436 | RSS: Main: 177381376 23:18:17 INFO - PROCESS | 28436 | 23:18:20 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-fft) 23:18:21 INFO - PROCESS | 28436 | RSS: Main: 160010240 23:18:21 INFO - PROCESS | 28436 | 23:18:22 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51490/tests/kraken/driver.html?testName=audio-oscillator) 23:18:23 INFO - PROCESS | 28436 | RSS: Main: 161980416 23:18:23 INFO - PROCESS | 28436 | 23:18:25 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:18:26 INFO - PROCESS | 28436 | RSS: Main: 164564992 23:18:26 INFO - PROCESS | 28436 | 23:18:29 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-darkroom) 23:18:29 INFO - PROCESS | 28436 | RSS: Main: 165027840 23:18:29 INFO - PROCESS | 28436 | 23:18:33 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51490/tests/kraken/driver.html?testName=imaging-desaturate) 23:18:33 INFO - PROCESS | 28436 | RSS: Main: 166567936 23:18:33 INFO - PROCESS | 28436 | 23:18:36 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51490/tests/kraken/driver.html?testName=json-parse-financial) 23:18:36 INFO - PROCESS | 28436 | RSS: Main: 166469632 23:18:36 INFO - PROCESS | 28436 | 23:18:38 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51490/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:18:39 INFO - PROCESS | 28436 | RSS: Main: 177410048 23:18:39 INFO - PROCESS | 28436 | 23:18:40 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:18:41 INFO - PROCESS | 28436 | RSS: Main: 176295936 23:18:41 INFO - PROCESS | 28436 | 23:18:43 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:18:44 INFO - PROCESS | 28436 | RSS: Main: 187412480 23:18:44 INFO - PROCESS | 28436 | 23:18:46 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:18:47 INFO - PROCESS | 28436 | RSS: Main: 192638976 23:18:47 INFO - PROCESS | 28436 | 23:18:49 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:18:50 INFO - PROCESS | 28436 | RSS: Main: 191258624 23:18:50 INFO - PROCESS | 28436 | 23:18:51 INFO - PROCESS | 28436 | Cycle 1(1): loaded http://localhost:51490/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51490/tests/kraken/driver.html?testName=ai-astar) 23:18:52 INFO - PROCESS | 28436 | RSS: Main: 250384384 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | __start_tp_report 23:18:52 INFO - PROCESS | 28436 | _x_x_mozilla_page_load 23:18:52 INFO - PROCESS | 28436 | _x_x_mozilla_page_load_details 23:18:52 INFO - PROCESS | 28436 | |i|pagename|runs| 23:18:52 INFO - PROCESS | 28436 | |0;ai-astar;109;111;103;109;111;110;100;109;109;116 23:18:52 INFO - PROCESS | 28436 | |1;audio-beat-detection;147;125;151;161;125;150;150;127;164;123 23:18:52 INFO - PROCESS | 28436 | |2;audio-dft;162;160;160;162;159;162;160;163;162;163 23:18:52 INFO - PROCESS | 28436 | |3;audio-fft;71;72;87;93;70;71;71;110;93;71 23:18:52 INFO - PROCESS | 28436 | |4;audio-oscillator;93;94;139;92;94;94;139;93;93;134 23:18:52 INFO - PROCESS | 28436 | |5;imaging-gaussian-blur;110;109;109;108;110;109;109;109;109;110 23:18:52 INFO - PROCESS | 28436 | |6;imaging-darkroom;145;146;145;146;144;146;146;146;145;146 23:18:52 INFO - PROCESS | 28436 | |7;imaging-desaturate;95;94;95;95;94;96;95;95;95;96 23:18:52 INFO - PROCESS | 28436 | |8;json-parse-financial;58;59;61;58;62;60;61;67;55;55 23:18:52 INFO - PROCESS | 28436 | |9;json-stringify-tinderbox;68;67;67;66;67;66;67;68;67;68 23:18:52 INFO - PROCESS | 28436 | |10;stanford-crypto-aes;84;83;85;85;84;84;84;92;93;92 23:18:52 INFO - PROCESS | 28436 | |11;stanford-crypto-ccm;117;121;117;121;121;115;125;125;116;123 23:18:52 INFO - PROCESS | 28436 | |12;stanford-crypto-pbkdf2;144;138;153;150;153;139;150;153;151;139 23:18:52 INFO - PROCESS | 28436 | |13;stanford-crypto-sha256-iterative;68;71;69;67;68;70;67;69;68;67 23:18:52 INFO - PROCESS | 28436 | __end_tp_report 23:18:52 INFO - PROCESS | 28436 | __start_cc_report 23:18:52 INFO - PROCESS | 28436 | _x_x_mozilla_cycle_collect,935 23:18:52 INFO - PROCESS | 28436 | __end_cc_report 23:18:52 INFO - PROCESS | 28436 | __startTimestamp1450768732229__endTimestamp 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | ------- Summary: start ------- 23:18:52 INFO - PROCESS | 28436 | Number of tests: 14 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.50 stddev:4.40 (4.0%) stddev-sans-first:4.66 23:18:52 INFO - PROCESS | 28436 | Values: 109.0 111.0 103.0 109.0 111.0 110.0 100.0 109.0 109.0 116.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:150.00 stddev:15.78 (10.5%) stddev-sans-first:16.65 23:18:52 INFO - PROCESS | 28436 | Values: 147.0 125.0 151.0 161.0 125.0 150.0 150.0 127.0 164.0 123.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 23:18:52 INFO - PROCESS | 28436 | Values: 162.0 160.0 160.0 162.0 159.0 162.0 160.0 163.0 162.0 163.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#3] audio-fft Cycles:10 Average:80.90 Median:71.50 stddev:14.01 (19.6%) stddev-sans-first:14.40 23:18:52 INFO - PROCESS | 28436 | Values: 71.0 72.0 87.0 93.0 70.0 71.0 71.0 110.0 93.0 71.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:21.33 (22.9%) stddev-sans-first:22.06 23:18:52 INFO - PROCESS | 28436 | Values: 93.0 94.0 139.0 92.0 94.0 94.0 139.0 93.0 93.0 134.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 23:18:52 INFO - PROCESS | 28436 | Values: 110.0 109.0 109.0 108.0 110.0 109.0 109.0 109.0 109.0 110.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 23:18:52 INFO - PROCESS | 28436 | Values: 145.0 146.0 145.0 146.0 144.0 146.0 146.0 146.0 145.0 146.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:18:52 INFO - PROCESS | 28436 | Values: 95.0 94.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 96.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.50 stddev:3.53 (5.8%) stddev-sans-first:3.70 23:18:52 INFO - PROCESS | 28436 | Values: 58.0 59.0 61.0 58.0 62.0 60.0 61.0 67.0 55.0 55.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 23:18:52 INFO - PROCESS | 28436 | Values: 68.0 67.0 67.0 66.0 67.0 66.0 67.0 68.0 67.0 68.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:4.01 (4.7%) stddev-sans-first:4.14 23:18:52 INFO - PROCESS | 28436 | Values: 84.0 83.0 85.0 85.0 84.0 84.0 84.0 92.0 93.0 92.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:121.00 stddev:3.67 (3.0%) stddev-sans-first:3.71 23:18:52 INFO - PROCESS | 28436 | Values: 117.0 121.0 117.0 121.0 121.0 115.0 125.0 125.0 116.0 123.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:150.50 stddev:6.32 (4.2%) stddev-sans-first:6.61 23:18:52 INFO - PROCESS | 28436 | Values: 144.0 138.0 153.0 150.0 153.0 139.0 150.0 153.0 151.0 139.0 23:18:52 INFO - PROCESS | 28436 | 23:18:52 INFO - PROCESS | 28436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 23:18:52 INFO - PROCESS | 28436 | Values: 68.0 71.0 69.0 67.0 68.0 70.0 67.0 69.0 68.0 67.0 23:18:52 INFO - PROCESS | 28436 | -------- Summary: end -------- 23:18:52 INFO - PROCESS | 28436 | 23:18:53 INFO - TEST-INFO | 28436: exit 0 23:18:53 INFO - TEST-OK | kraken | took 58345ms 23:18:53 INFO - TEST-START | v8_7 23:18:53 INFO - operating with platform_type : linux_ 23:18:53 INFO - Initialising browser for v8_7 test... 23:18:53 INFO - TEST-INFO | started process 28687 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXOeixq/profile http://localhost:51490/getInfo.html) 23:18:56 INFO - PROCESS | 28687 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 23:18:56 INFO - PROCESS | 28687 | __metrics Screen width/height:1600/1200 23:18:56 INFO - PROCESS | 28687 | colorDepth:24 23:18:56 INFO - PROCESS | 28687 | Browser inner width/height: 1024/697 23:18:56 INFO - PROCESS | 28687 | __metrics 23:18:56 INFO - PROCESS | 28687 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:18:57 INFO - PROCESS | 28687 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:18:58 INFO - TEST-INFO | 28687: exit 0 23:18:58 INFO - Browser initialized. 23:18:58 INFO - Running cycle 1/1 for v8_7 test... 23:18:58 INFO - TEST-INFO | started process 28765 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXOeixq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:19:09 INFO - PROCESS | 28765 | RSS: Main: 149762048 23:19:09 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | Cycle 1(1): loaded http://localhost:51490/tests/v8_7/run.html (next: http://localhost:51490/tests/v8_7/run.html) 23:19:31 INFO - PROCESS | 28765 | RSS: Main: 613765120 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | __start_tp_report 23:19:31 INFO - PROCESS | 28765 | _x_x_mozilla_page_load 23:19:31 INFO - PROCESS | 28765 | _x_x_mozilla_page_load_details 23:19:31 INFO - PROCESS | 28765 | |i|pagename|runs| 23:19:31 INFO - PROCESS | 28765 | |0;Richards;165.42597187758477 23:19:31 INFO - PROCESS | 28765 | |1;DeltaBlue;189.10741301059002 23:19:31 INFO - PROCESS | 28765 | |2;Encrypt;279.72027972027973 23:19:31 INFO - PROCESS | 28765 | |3;Decrypt;5186.5284974093265 23:19:31 INFO - PROCESS | 28765 | |4;RayTrace;1091.703056768559 23:19:31 INFO - PROCESS | 28765 | |5;Earley;778.816199376947 23:19:31 INFO - PROCESS | 28765 | |6;Boyer;11952.380952380952 23:19:31 INFO - PROCESS | 28765 | |7;RegExp;25400 23:19:31 INFO - PROCESS | 28765 | |8;Splay;678.42605156038 23:19:31 INFO - PROCESS | 28765 | |9;NavierStokes;4840.579710144928 23:19:31 INFO - PROCESS | 28765 | __end_tp_report 23:19:31 INFO - PROCESS | 28765 | __startTimestamp1450768771616__endTimestamp 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | ------- Summary: start ------- 23:19:31 INFO - PROCESS | 28765 | Number of tests: 10 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#0] Richards Cycles:1 Average:165.43 Median:165.43 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 165.4 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#1] DeltaBlue Cycles:1 Average:189.11 Median:189.11 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 189.1 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 279.7 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 5186.5 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 1091.7 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#5] Earley Cycles:1 Average:778.82 Median:778.82 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 778.8 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 11952.4 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#7] RegExp Cycles:1 Average:25400.00 Median:25400.00 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 25400.0 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#8] Splay Cycles:1 Average:678.43 Median:678.43 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 678.4 23:19:31 INFO - PROCESS | 28765 | 23:19:31 INFO - PROCESS | 28765 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 23:19:31 INFO - PROCESS | 28765 | Values: 4840.6 23:19:31 INFO - PROCESS | 28765 | -------- Summary: end -------- 23:19:31 INFO - PROCESS | 28765 | 23:19:32 INFO - TEST-INFO | 28765: exit 0 23:19:32 INFO - TEST-OK | v8_7 | took 39389ms 23:19:32 INFO - SUITE-END | took 1210s 23:19:32 INFO - Completed test suite (00:20:10) 23:19:32 INFO - Working with test: dromaeo_css 23:19:32 INFO - Generating results file: dromaeo_css 23:19:32 INFO - Working with test: kraken 23:19:32 INFO - Generating results file: kraken 23:19:32 INFO - javascript benchmark 23:19:32 INFO - Working with test: v8_7 23:19:32 INFO - Generating results file: v8_7 23:19:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:19:32 INFO - process_Request line: dromaeo_css 6923.56 graph.html#tests=[[72,201,35]] 23:19:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:32 INFO - process_Request line: kraken 1498.20 graph.html#tests=[[232,201,35]] 23:19:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:19:32 INFO - process_Request line: v8_7 20938.26 graph.html#tests=[[230,201,35]] 23:19:32 INFO - RETURN: dromaeo_css: 6923.56 23:19:32 INFO - RETURN: kraken: 1498.20 23:19:32 INFO - RETURN: v8_7: 20938.26 23:19:32 INFO - javascript benchmark 23:19:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3109.082820567933, 3152.3222507160954, 3202.8558714857845, 3208.1819136120303, 3211.0, 5139.434662187156, 5232.398274198468, 5239.476052394759, 5258.474152584739, 5323.174907889278, 5180.792768289264, 5209.661372010826, 5231.712255825928, 5235.79056837727, 5290.894182116355, 4810.254410566359, 4819.638527110464, 4831.985283090556, 4892.608591312686, 4924.630652701044, 4708.952910470903, 4911.410630724318, 4928.186849169882, 4941.258811178316, 5000.624953128512, 4722.527747225285, 4785.832495862628, 4801.759912004386, 4801.951980480186, 4813.711177329354, 4809.663323567352, 4816.710997340171, 4817.879553011167, 4822.63830212732, 4857.611391088704, 4681.88295292617, 4782.760861956888, 4806.495317991596, 4814.518548145193, 4863.537963893425, 5135.563477104451, 5163.0, 5254.21186821976, 5265.262863199156, 5280.762365693553, 5680.801171959003, 5691.630044047124, 5691.9146212806845, 5692.430756924316, 5693.259876216065, 5481.725913704299, 5603.159526071081, 5667.574931880125, 5668.149777533362, 5670.801521946753, 5242.842714718565, 5257.0, 5261.105612045962, 5272.077386457393, 5280.894382112375, 5779.88440231193, 5787.797427090031, 5791.971040144772, 5792.275965504312, 5795.768169273266, 5442.12925931849, 5527.115661494222, 5607.80372686954, 5611.298587676541, 5612.0, 5565.610407271533, 5569.916451253234, 5631.380548139701, 5642.943570564324, 5691.68695721731, 5558.610897237236, 5585.1901474286005, 5597.076482380362, 5598.272224610774, 5598.804041858515, 5486.561075113981, 5591.9720401398545, 5607.102863541895, 5612.663240205601, 5613.270274864241, 4365.672574556921, 4428.490723566831, 4433.246348120827, 4465.285554311359, 4475.462944446687, 3927.3912543555793, 3945.684345252373, 3948.072203032285, 3962.7622342659533, 3990.8004599769897, 5190.662606930538, 5280.498352656491, 5289.0, 5353.2237825515085, 5421.5391691706645, 5526.972365138148, 5561.193626924073, 5604.747786349624, 5630.296212973379, 5640.012997725382, 5338.279332290169, 5339.706316152571, 5341.145416733381, 5341.839744807662, 5342.572594192533, 4891.290762839369, 4964.950350496449, 4973.875653108629, 5002.274670172877, 5016.598672106223, 5761.0, 5834.795782147689, 5837.211976383219, 5841.06542953134, 5882.0, 5756.107803290497, 5764.855878603068, 5786.94213057864, 5787.6816775076095, 5787.6816775076095, 5761.0, 5841.0, 5866.911996320144, 5894.086416605433, 5906.143609176731, 5535.474129957647, 5571.8885622288135, 5587.8882422352135, 5590.608657393944, 5612.242347283064, 5672.546196304368, 5701.4298570142655, 5706.3152421709665, 5707.372189059117, 5735.7418916148035, 5311.123664595299, 5441.863953401038, 5578.135389014709, 5586.1062230043, 5597.63615365, 5480.835574932758, 5537.7784888604, 5539.196816461671, 5541.141123125922, 5585.106382978866, 5450.563954883521, 5474.616776825584, 5477.643953143033, 5478.863028424162, 5479.2602998594675, 5398.811041613525, 5405.216243644571, 5500.862478438071, 5580.707293342064, 5634.4365563443325, 5348.679079255257, 5405.567554595702, 5414.648047876875, 5416.729163541886, 5462.20797984298], "unit": "score", "name": "dojo.html", "value": 5222.018873521747}, {"lowerIsBetter": false, "replicates": [545.52603941127, 588.9234399528062, 607.5777334752347, 612.3019757476475, 616.3805375597524, 29193.56209656854, 29935.1019469416, 37663.24673506528, 38469.42295865564, 38589.61410385902, 43128.568714312845, 43454.34818477726, 43636.345454818205, 43654.563454365445, 43661.0, 7628.427867909902, 7751.728689495869, 8796.999999999984, 8965.686200982967, 8976.461412315282, 10188.032136946978, 10349.120324772404, 10398.272120951537, 10421.114205292559, 10468.633597824077, 10175.542100605453, 10190.439525826077, 10220.591176352937, 10273.794524109513, 10291.742706432324, 7854.0, 8062.677492900277, 10224.74438139045, 10565.894341056568, 10835.404052777094, 10353.896461035369, 10489.737756556071, 10493.475326233658, 10493.63272285474, 10497.160227181806, 40611.390829137585, 40639.18721625581, 40879.1824163518, 40929.79535102335, 41036.58963410358, 3265.6571060038827, 3286.260591366947, 3435.7766745161484, 3493.982530087333, 3788.488554045196, 29700.851495742383, 30036.399272014656, 30145.698543014507, 30366.240843978856, 30442.54336184959, 3881.243157584272, 4042.333015052513, 4053.412255222976, 4067.0, 4084.7344922580232, 262655.0, 265569.0, 265885.0, 266334.0, 266747.0, 52522.73738631359, 53438.7328063365, 59915.0, 60157.69921150366, 60192.699036505415, 70456.64771676109, 70530.53633563903, 70924.29075709281, 70930.0, 71005.2899471009, 15683.764743528856, 15856.52430427089, 15946.681066378607, 15991.440299589458, 16006.679866402606, 11892.524299028115, 12034.0, 12057.577984770667, 12079.57721479744, 12124.575639852563, 19933.700994485094, 20073.598528029357, 20161.39515814528, 20238.898805506175, 20389.694154587694, 7736.381089512825, 7851.291304499939, 7889.605519723991, 7900.84198316042, 7985.880211796828, 888.9422187557788, 891.433939448442, 1035.2132379391567, 1046.35126221743, 1079.9892001079888, 27653.0, 27748.306292342448, 27943.58084628732, 28317.57523637147, 28373.574396384072, 1002.173207104142, 1057.3127467146417, 1075.0, 1096.9670909872716, 1148.4774427635407, 13829.446822127002, 13950.23273719955, 14034.719305613831, 14073.85926140746, 14137.78793318101, 371102.0, 375480.0, 375524.0, 375855.0, 376688.0, 50736.49263507391, 51128.0, 51161.74419127955, 51234.23148652773, 51659.22511162335, 1199.7300607363447, 1250.8123781432857, 1268.7716211081909, 1271.0086132816418, 1371.8902487801151, 26948.461030778883, 27545.862270688518, 27936.0, 28009.299767505974, 28160.0, 40659.0, 41022.38466422947, 41373.79313103415, 41426.37860432036, 41428.79285603553, 176748.0, 370347.0, 371965.0, 373482.0, 374173.0, 28745.281367965967, 29359.853200734713, 29462.852685736434, 29508.262293442836, 29536.113916582537, 40979.38530921979, 41841.58158418498, 41884.16231675288, 42033.0, 42707.3593896098, 35155.472667910515, 35245.47131792974, 35421.46867797037, 35442.8227858859, 36159.819200903825, 34879.0, 35448.46827297644, 35492.46761298531, 35564.466533002545, 35627.0, 35218.82390588031, 35469.82265088658, 39736.2052758949, 40827.7958610205, 40999.38500922548, 30423.84788076134, 32148.678513214567, 32208.516872246466, 32494.51258231081, 32686.509702354007, 24616.0, 24743.38141546476, 24857.0, 25185.87407062953, 25248.242552723448], "unit": "score", "name": "ext.html", "value": 18854.6390411157}, {"lowerIsBetter": false, "replicates": [332.54109329125794, 337.2395248714149, 337.6808915574781, 337.8344611140542, 343.4007656639165, 14433.711325773504, 14738.484153054618, 16182.75725864113, 16295.918520407396, 18431.90784046081, 14353.712925741505, 14427.27863606818, 15944.20278986049, 15993.200339982983, 16520.0, 5148.459411761758, 5276.736163191844, 5295.179247216668, 5297.205419187134, 5298.576113910897, 3783.2244389900143, 3877.3214687429727, 5190.948090519084, 5248.0553500369915, 5287.021900948318, 5433.994710978462, 5541.639793413416, 5545.223668686387, 5583.246261754672, 5583.553315734732, 5455.672659640434, 5546.112621980484, 5547.195656629786, 6032.939670603281, 6041.818745437644, 5359.383670877821, 5378.489043540857, 5380.300560927094, 5381.730913454312, 5382.869597384554, 12420.81368779469, 12932.676683082904, 13444.0, 13451.260180690058, 13488.258145802076, 2143.506993391513, 2153.6554151335868, 2192.254633424627, 2296.127471560796, 2303.7235531736133, 9617.759556011086, 9801.460919649417, 9855.310128291023, 9964.402135871871, 9982.051705088077, 1805.2688661092147, 1809.11353436815, 1859.9907000465046, 1861.153175305233, 1877.4180004198743, 58387.41612583862, 62116.37883621197, 62311.37688623101, 62322.37677623211, 62938.05592916064, 9961.55173017216, 10220.131288840532, 10349.689509314732, 10363.274570779973, 10431.113355364727, 13644.249566273751, 13668.0, 13729.382177802023, 13766.31168441574, 13767.105138165987, 7272.163701174327, 7312.926870731225, 7314.232005639437, 7497.66260518278, 7689.307962283421, 6867.3476019778045, 6974.16310042788, 6999.440044796404, 7079.327463890922, 7081.92918070823, 4354.804033818486, 4420.535843736361, 4421.867343979686, 4426.734395936254, 4448.310511870665, 1712.5033740215447, 1724.922378492971, 1815.9001254931106, 1840.3282801777523, 1855.2022630268843, 870.8650159225331, 891.2424439226735, 990.2325697584286, 1031.5254982707888, 1053.752368193474, 15651.295691693902, 16259.001428243328, 17052.744208836877, 17239.0, 17433.21550530204, 933.5612262236738, 942.1332374215738, 963.2390411574918, 964.2334344196381, 975.7267964969819, 9567.282453815991, 9814.411135331902, 9912.653057142965, 9948.701538953843, 10259.230557708202, 504339.0, 548517.0, 553616.0, 553839.0, 554393.0, 70421.6478917602, 79973.0, 81612.59193703994, 82822.0, 85497.0, 1165.3241120150292, 1177.0642339340245, 1184.3249347871804, 1189.756099999498, 1198.2151690642818, 15148.697026059197, 15554.589038698567, 15633.280339162911, 15666.530004099895, 15966.281517331516, 35003.82498087595, 35229.647703522634, 35642.10894727652, 35644.643553564136, 36102.63897361098, 47383.289250661954, 47612.0, 48912.51087489222, 49933.75033124811, 50945.0, 9635.13283804461, 9680.27397945143, 9827.52587111939, 9828.852567211354, 9835.311528192959, 16616.91691541583, 17229.22468488946, 17511.82488175102, 17698.734518982485, 17814.376496822548, 11556.88443115558, 12049.277043377426, 13876.0, 14069.577912662637, 14073.648158796112, 13318.933405332911, 13430.030888571291, 13478.32608369558, 13869.861301386856, 13889.166650001032, 13868.167909925436, 13874.722505550035, 14108.0, 14625.85374146245, 15071.397144114551, 9776.608935642495, 9814.950925245328, 9895.109440150422, 9897.802043959224, 9902.702918912444, 13618.455261789417, 13849.930750346184, 13976.231307278198, 14639.560813175622, 14649.340779664728], "unit": "score", "name": "jquery.html", "value": 8761.44969321798}, {"lowerIsBetter": false, "replicates": [1327.4623777370168, 1645.292524214588, 1654.2225154177534, 1668.0325411261476, 1720.898624880077, 6787.389134977851, 7506.774796756093, 7696.692132314701, 7712.652930618122, 7717.112532058822, 7557.735479258227, 7644.885326720104, 7652.846943061136, 7674.961625191866, 7696.615169241543, 1933.82595566399, 1966.7443232379842, 1966.9704954425695, 2256.8758718270446, 2309.1225334372916, 2001.0495014867968, 2281.7832305930992, 2320.9419764505856, 2324.337563794319, 2325.965110523335, 2240.8431409801237, 2248.291788086756, 2256.9661455078185, 2258.762829902861, 2300.3903965449085, 2262.9434264143365, 2263.287064574654, 2284.463151159476, 2284.828637852168, 2286.5198308355184, 2282.3837563857664, 2303.170858490942, 2303.3550605830396, 2304.4699719064542, 2306.573283942459, 7607.125180604246, 7696.615169241515, 7697.0, 7699.461037727361, 7709.537427754352, 4646.163690535702, 4712.787924543404, 4717.882052948669, 4734.928976065362, 4746.121967436035, 3067.9233019174476, 3107.9533806992913, 3112.3464072544793, 3127.9687203128133, 3139.2779660677943, 998.8102260570469, 1003.9247056470793, 1015.3653966271081, 1027.5222021759917, 1052.9262951593391, 10289.794204115951, 10357.896421035844, 10388.948055259676, 10402.843957340647, 10442.791144177074, 4176.352665336817, 4183.958160418418, 4231.640310573574, 4240.872773816729, 4271.508776490681, 9066.682666106655, 9095.31785116119, 9126.08739126082, 9126.81746365069, 9132.543372831331, 4537.205988951986, 4560.566746159109, 4578.267477203632, 4584.4957054723955, 4590.219662657356, 4157.168566286755, 4172.08214192877, 4199.4330765346895, 4200.789960501963, 4211.831526738957, 3296.225387034045, 3675.448682697563, 3679.7608155469807, 3688.7233457490797, 3741.9064523387133, 1094.7372630568607, 1112.67732357617, 1175.9823602645968, 1181.2203945395997, 1186.602488166474, 1057.1965306367063, 1058.2697938422464, 1061.4480470155477, 1194.7132688154954, 1320.7886738121854, 7283.126024877049, 7329.780106596811, 7384.52000619958, 7384.556926584422, 7396.112466504054, 1100.8018556659717, 1116.553378648547, 1133.3766428464312, 1143.6226045404997, 1156.9652910412701, 5710.942890571124, 5840.737166827503, 5865.853353666193, 5870.119482077637, 5885.911711324334, 8822.691205807765, 8944.955275223712, 9007.684731034382, 9080.137386948229, 9152.450852948845, 9085.318601104944, 9094.727158185266, 9165.220956218664, 9201.585928633094, 9204.4477331359, 6968.268331825187, 7224.241454647292, 7249.565026098451, 7300.306470885257, 7315.0, 7226.060612120391, 7269.600171990592, 7279.672414741243, 7280.0535930328715, 7285.7814265572115, 8073.919260807552, 8160.83678326442, 8238.711645092393, 8353.24820766134, 8368.874466883124, 8401.327893768606, 8497.065322814362, 8626.78433039179, 8629.39594228398, 8649.351298652751, 6474.093626892145, 6630.0, 6770.424513916372, 6843.349881761224, 6849.794506164823, 6668.899966500409, 6763.628000460022, 7413.740519081806, 7443.069616297963, 7452.180260171485, 6663.267040625624, 6793.796186114425, 6811.727530898708, 6851.828704282433, 7025.508214424941, 6637.369449902251, 6809.399791049001, 6864.897026544506, 6920.550164239308, 6985.545939513915, 6804.251532331341, 6840.179178498612, 6840.3501667341525, 6841.213260475109, 6856.897146542706, 6275.529335299962, 6316.936830631635, 6318.27339855904, 6324.778632747832, 6338.809835704937, 6488.9026664601015, 6583.3087525811015, 6602.570832895846, 6602.900956485752, 6605.207375115017], "unit": "score", "name": "mootools.html", "value": 4438.492952582742}, {"lowerIsBetter": false, "replicates": [322.2636276109091, 329.4843569813242, 330.04616657858776, 332.61250643000903, 335.0234067692676, 5973.074173503103, 6035.607685500445, 6038.728257228424, 6039.72821223045, 6044.335123136451, 5717.742701578429, 5777.19119323295, 5849.239598852143, 5968.79109231177, 5982.162497250389, 4567.1550763108935, 4586.289125185584, 4589.954100458986, 4593.655475839309, 4601.608863246628, 4589.632829373642, 4595.839145629903, 4596.6322694184555, 4599.218132917412, 4601.171789077965, 4368.322909948947, 4462.642988560908, 4464.46426428829, 4575.977120114395, 4592.012717265788, 4558.0, 4560.589546940775, 4564.8174073037035, 4576.656750743691, 4593.219152744042, 4033.052232725307, 4059.9594004059877, 4061.2892743770017, 4064.9390259146135, 4067.5525692174133, 5639.464250896158, 5662.518685911702, 5663.773449062032, 5669.177969194444, 5670.121131224667, 5123.1546794778815, 5265.7893684252585, 5267.157254839208, 5293.385517417186, 5322.866928326823, 6332.841678958017, 6336.429721325057, 6338.936610633881, 6341.207349081365, 6344.238691357021, 4424.159409712144, 4425.137098265839, 4427.424434823452, 4429.911401771947, 4430.047539778963, 6443.613383197023, 6503.414692677635, 6585.242697089848, 6592.373724496165, 6600.405963463311, 4432.578905004019, 4433.889152771142, 4436.933445998313, 4438.556144385536, 4438.755868427203, 4477.1493416250805, 4479.664025198123, 4483.955160448354, 4488.820447182076, 4492.797824097924, 5227.790888364499, 5230.97384513075, 5238.1618940969265, 5242.868928276747, 5248.475152484797, 6285.874282514415, 6397.232332120082, 6400.871982560323, 6403.96798016007, 6407.070974708641, 1561.8203906550664, 1572.9932842980502, 1575.22026596833, 1575.487966410921, 1576.1646327446472, 1035.803197392493, 1042.8227201375785, 1042.9165666746642, 1050.2805578178973, 1061.0397590180899, 6069.908951365733, 6073.362296958756, 6078.392160783975, 6086.452219300284, 6088.573799834057, 6553.180852393451, 6576.901346479806, 6585.539012269191, 6587.209534855848, 6594.7032383542855, 5914.9112763308585, 5941.22764040672, 6061.666608336495, 6079.0, 6111.8472038198515, 3548.485469606944, 3566.625504322061, 3569.303985722811, 3570.6786389225094, 3572.303400836864, 6754.864902701918, 6758.222804377461, 6765.42493888025, 6771.119754431991, 6803.829904252433, 6551.181102362205, 6774.085498457645, 6782.457403407716, 6789.592624442451, 6790.490713196431, 6750.0, 6789.083473730983, 6797.796066118024, 6801.1158549388265, 6804.693788779517, 6577.80266592003, 6613.974833900753, 6624.503162262946, 6638.20341559016, 6638.668066596748, 6340.556161068866, 6531.542792004514, 6540.280569137486, 6546.8363290918105, 6550.312217217123, 6765.627890466071, 6781.6948237330425, 6787.253402125663, 6793.966030169818, 6796.218434880052, 4419.535948725466, 4441.156180325728, 4447.755373454491, 4449.911001780011, 4461.888452788707, 6405.967970160119, 6613.867722645424, 6620.0, 6641.26946035926, 6641.933580664131, 6452.548321617442, 6469.061986011908, 6473.2232132144445, 6479.967600162157, 6480.837979050561, 6449.903251451138, 6450.193725784277, 6456.870862582816, 6463.321351258238, 6466.741330346922, 6170.3212646607935, 6322.114903913548, 6332.905006424815, 6343.238811342669, 6346.111544383883, 6436.098946147449, 6439.581427207217, 6440.935590644221, 6445.677716114082, 6453.741190583259, 6189.195404597373, 6331.3352098029045, 6337.904931426125, 6338.714757835816, 6344.68276586178], "unit": "score", "name": "prototype.html", "value": 4784.706816193795}, {"lowerIsBetter": false, "replicates": [683.5659356308744, 693.8230751158454, 747.8242612985944, 747.9626018699065, 757.1633345153605, 13421.463141474342, 13663.453461861514, 13678.931605341972, 13681.589552313446, 13685.72628547431, 12798.616041518746, 14519.346629401676, 14728.0, 14769.0, 14800.0, 706.8974998625197, 711.2212127720138, 831.4803247970019, 835.0271933197818, 850.5662112322728, 842.595554134013, 846.3525403066628, 850.1116333431548, 850.4429598612918, 851.6125163050827, 888.205056474455, 893.0667452512108, 894.4812009034777, 894.8612964990405, 894.8881389826272, 723.7683941138838, 732.8534293141366, 873.1443185678007, 882.832261870249, 884.8009197930478, 653.1998302079961, 653.4837478392064, 653.8071268975664, 653.8430776613626, 654.0908137688616, 12873.420696068699, 13063.934680326633, 13133.60599182026, 13154.144980576328, 13166.078374513789, 11297.435128243555, 11408.771824563546, 11650.610593537578, 11666.125040621988, 12682.112252142353, 9411.952940235324, 9423.90576094237, 9480.668176613854, 9569.234461243084, 9661.806763864683, 3332.1169889979174, 3392.508086327469, 3392.6607339266125, 3411.4371128763723, 3426.7258619310396, 47394.526054739355, 48013.0, 48135.75932120352, 48262.0, 48264.517354826356, 9249.398789078688, 9274.999999999865, 9351.812963740687, 9391.671291504765, 9449.858252126223, 18755.812441875678, 18941.905290473736, 18964.336248231244, 18966.051697415074, 19144.138513766913, 6839.487038472134, 6864.965675171592, 6872.450203983669, 6894.0, 7022.859542809115, 3912.080661044652, 3953.6244056814558, 3972.483577134954, 4005.91988160241, 4030.9395359069636, 2922.7515661168613, 2955.453241150351, 2956.926076848096, 2958.156925276286, 2962.555616657519, 557.8103444828778, 581.221163640715, 586.920765696634, 588.7968650815462, 591.7869566955892, 548.3858078951599, 631.4884943196026, 633.8510450044236, 645.9806205813833, 666.7899611622323, 7907.604619768988, 7954.721584744506, 8084.919150808534, 8142.47073940192, 8286.70996515119, 641.4771960851891, 654.7479220500046, 661.4344735251387, 678.3149019490351, 682.436989483678, 3594.946075808865, 3857.3442514772555, 3908.3746600543777, 3946.940795888064, 3992.9815517908364, 54123.18815217696, 54231.186532202046, 54691.0, 54961.450385496435, 55200.17199742007, 47678.28482572764, 47732.7613361931, 47803.0, 47895.0, 48577.38514841155, 44058.0, 44248.55751442509, 44850.32724509135, 44863.10273794571, 45064.324035140155, 7632.542047477169, 7652.719623459795, 7846.450748447553, 7943.602819858868, 8053.6778528858185, 34309.82845085759, 34514.654853451146, 34588.30823383568, 35148.12129696778, 35604.46593301155, 42956.35565466583, 43564.12871742484, 43814.78092609517, 44132.779336103114, 44221.33667995047, 10002.749931251486, 10068.144207742424, 10076.848847267443, 10142.89857101449, 10243.0, 10279.229057820843, 10290.434026128634, 10313.0, 10593.576256949636, 10696.358218506915, 9709.271804614824, 9739.464329461947, 9750.853737193806, 9834.803303934024, 9940.602375904882, 9977.900220997697, 9981.900180998387, 10137.290389672653, 10189.286749927434, 10320.535575898952, 9330.346875718635, 9433.858492122761, 9496.382735122195, 9564.713058608253, 9857.556409961713, 8108.040987229994, 8221.17788221173, 8274.931941357128, 8504.319654427754, 8635.438696484709, 8003.599820009093, 8054.597270136587, 8109.7161599343735, 8203.876941845758, 8414.915850841413], "unit": "score", "name": "yui.html", "value": 6011.911632447952}], "name": "dromaeo_css", "value": 6923.558867518097}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 103.0, 109.0, 111.0, 110.0, 100.0, 109.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [147.0, 125.0, 151.0, 161.0, 125.0, 150.0, 150.0, 127.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 162.0, 159.0, 162.0, 160.0, 163.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 87.0, 93.0, 70.0, 71.0, 71.0, 110.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 139.0, 92.0, 94.0, 94.0, 139.0, 93.0, 93.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 108.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 144.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 61.0, 58.0, 62.0, 60.0, 61.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 85.0, 85.0, 84.0, 84.0, 84.0, 92.0, 93.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [117.0, 121.0, 117.0, 121.0, 121.0, 115.0, 125.0, 125.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [144.0, 138.0, 153.0, 150.0, 153.0, 139.0, 150.0, 153.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 67.0, 68.0, 70.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1498.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.42597187758477], "unit": "score", "name": "Richards", "value": 213.40059000000002}, {"lowerIsBetter": false, "replicates": [189.10741301059002], "unit": "score", "name": "DeltaBlue", "value": 349.631984}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1091.703056768559], "unit": "score", "name": "RayTrace", "value": 677.8299240000001}, {"lowerIsBetter": false, "replicates": [778.816199376947], "unit": "score", "name": "Earley", "value": 855.7384919999998}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [25400.0], "unit": "score", "name": "RegExp", "value": 35.86555118110237}, {"lowerIsBetter": false, "replicates": [678.42605156038], "unit": "score", "name": "Splay", "value": 120.11773399999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20938.257511798507}]} 23:19:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20938.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1498.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6923.56"}}} 23:19:32 INFO - Return code: 0 23:19:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:19:32 ERROR - # TBPL SUCCESS # 23:19:32 INFO - Running post-action listener: _resource_record_post_action 23:19:32 INFO - Running post-run listener: _resource_record_post_run 23:19:33 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560807936; Read time: 8; Write time: 484080 23:19:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248872960; Read time: 0; Write time: 312912 23:19:33 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311934976; Read time: 8; Write time: 171168 23:19:33 INFO - Running post-run listener: _upload_blobber_files 23:19:33 INFO - Blob upload gear active. 23:19:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:19:33 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 23:19:33 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:19:33 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:19:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:35 INFO - (blobuploader) - INFO - Done attempting. 23:19:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:19:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:19:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:19:36 INFO - (blobuploader) - INFO - Done attempting. 23:19:36 INFO - (blobuploader) - INFO - Iteration through files over. 23:19:36 INFO - Return code: 0 23:19:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:19:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:19:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e270f63d34f23341d2697c100e9d8dfce5e434d879197c56148679a74d330ff11f988912cdd46cf68f94fe542eb959949440090e299c762cfe00fc037c573019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6bdb8a891bb4ba05d244fca89989889ee80b31cc70498363570d473ddb22eae2aacd5ad3369680d77969228bead3afc3486888082346edc192d76e0084305e2a"} 23:19:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:19:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:19:36 INFO - Contents: 23:19:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e270f63d34f23341d2697c100e9d8dfce5e434d879197c56148679a74d330ff11f988912cdd46cf68f94fe542eb959949440090e299c762cfe00fc037c573019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6bdb8a891bb4ba05d244fca89989889ee80b31cc70498363570d473ddb22eae2aacd5ad3369680d77969228bead3afc3486888082346edc192d76e0084305e2a"} 23:19:36 INFO - Copying logs to upload dir... 23:19:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.747862 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-21 23:19:35.829980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 23:19:35.833807) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/e270f63d34f23341d2697c100e9d8dfce5e434d879197c56148679a74d330ff11f988912cdd46cf68f94fe542eb959949440090e299c762cfe00fc037c573019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6bdb8a891bb4ba05d244fca89989889ee80b31cc70498363570d473ddb22eae2aacd5ad3369680d77969228bead3afc3486888082346edc192d76e0084305e2a"} build_url:https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/mTTDntvvQUmxCtJED5cC2Q/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/B2G-Inbound/sha512/e270f63d34f23341d2697c100e9d8dfce5e434d879197c56148679a74d330ff11f988912cdd46cf68f94fe542eb959949440090e299c762cfe00fc037c573019", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/6bdb8a891bb4ba05d244fca89989889ee80b31cc70498363570d473ddb22eae2aacd5ad3369680d77969228bead3afc3486888082346edc192d76e0084305e2a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 23:19:35.858656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 23:19:35.858997) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1450756836.468430-246727471 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 23:19:35.941349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 23:19:35.941672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 23:19:35.942013) ========= ========= Total master_lag: 0.24 =========