builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1453353017.41 results: success (0) buildid: 20160120185004 builduid: 92f548a05d6e4c959339d5b9fa7abbe6 revision: 493d6820745e4e3ed22e48a5f9229ea033a64a3a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.408123) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.408587) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.408882) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.434193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.434513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.468730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.469013) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.516947) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.517268) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.517647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.517924) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 21:10:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.5M=0s 2016-01-20 21:10:17 (55.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099439 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.629922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.630258) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063778 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.706184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:17.706538) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 493d6820745e4e3ed22e48a5f9229ea033a64a3a --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/fx-team --rev 493d6820745e4e3ed22e48a5f9229ea033a64a3a --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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 21:10:17,763 truncating revision to first 12 chars 2016-01-20 21:10:17,763 Setting DEBUG logging. 2016-01-20 21:10:17,763 attempt 1/10 2016-01-20 21:10:17,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/493d6820745e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 21:10:17,997 unpacking tar archive at: fx-team-493d6820745e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.245564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.245892) ========= echo 493d6820745e4e3ed22e48a5f9229ea033a64a3a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'493d6820745e4e3ed22e48a5f9229ea033a64a3a'] 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 493d6820745e4e3ed22e48a5f9229ea033a64a3a program finished with exit code 0 elapsedTime=0.004701 script_repo_revision: '493d6820745e4e3ed22e48a5f9229ea033a64a3a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.295382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.295670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.305319) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.305572) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/493d6820745e4e3ed22e48a5f9229ea033a64a3a ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 21:10:18.305925) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-20 21:10:18.306229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:10:18 INFO - MultiFileLogger online at 20160120 21:10:18 in /builds/slave/test-pgo 21:10:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:10:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:10:18 INFO - {'append_to_log': False, 21:10:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:10:18 INFO - 'blob_upload_branch': 'Fx-Team', 21:10:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:10:18 INFO - 'branch': 'Fx-Team', 21:10:18 INFO - 'buildbot_json_path': 'buildprops.json', 21:10:18 INFO - 'config_files': ('talos/linux_config.py',), 21:10:18 INFO - 'default_actions': ('clobber', 21:10:18 INFO - 'read-buildbot-config', 21:10:18 INFO - 'download-and-extract', 21:10:18 INFO - 'populate-webroot', 21:10:18 INFO - 'create-virtualenv', 21:10:18 INFO - 'install', 21:10:18 INFO - 'run-tests'), 21:10:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:10:18 INFO - 'download_minidump_stackwalk': True, 21:10:18 INFO - 'download_symbols': 'ondemand', 21:10:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:10:18 INFO - 'tooltool.py': '/tools/tooltool.py', 21:10:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:10:18 INFO - '/tools/misc-python/virtualenv.py')}, 21:10:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:10:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:10:18 INFO - 'installer_path': 'installer.exe', 21:10:18 INFO - 'log_level': 'info', 21:10:18 INFO - 'log_name': 'talos', 21:10:18 INFO - 'log_to_console': True, 21:10:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:10:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:10:18 INFO - 'opt_config_files': (), 21:10:18 INFO - 'pip_index': False, 21:10:18 INFO - 'sps_profile': False, 21:10:18 INFO - 'sps_profile_interval': 0, 21:10:18 INFO - 'suite': 'dromaeojs', 21:10:18 INFO - 'system_bits': '32', 21:10:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:10:18 INFO - 'title': 'talos-linux64-ix-047', 21:10:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:10:18 INFO - 'use_talos_json': True, 21:10:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:10:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:10:18 INFO - 'work_dir': 'build'} 21:10:18 INFO - ##### 21:10:18 INFO - ##### Running clobber step. 21:10:18 INFO - ##### 21:10:18 INFO - Running pre-action listener: _resource_record_pre_action 21:10:18 INFO - Running main action method: clobber 21:10:18 INFO - rmtree: /builds/slave/test-pgo/build 21:10:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:10:19 INFO - Running post-action listener: _resource_record_post_action 21:10:19 INFO - ##### 21:10:19 INFO - ##### Running read-buildbot-config step. 21:10:19 INFO - ##### 21:10:19 INFO - Running pre-action listener: _resource_record_pre_action 21:10:19 INFO - Running main action method: read_buildbot_config 21:10:19 INFO - Using buildbot properties: 21:10:19 INFO - { 21:10:19 INFO - "project": "", 21:10:19 INFO - "product": "firefox", 21:10:19 INFO - "script_repo_revision": "production", 21:10:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:10:19 INFO - "repository": "", 21:10:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:10:19 INFO - "buildid": "20160120185004", 21:10:19 INFO - "pgo_build": "True", 21:10:19 INFO - "basedir": "/builds/slave/test-pgo", 21:10:19 INFO - "buildnumber": 592, 21:10:19 INFO - "slavename": "talos-linux64-ix-047", 21:10:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:10:19 INFO - "platform": "ubuntu64_hw", 21:10:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:10:19 INFO - "branch": "fx-team", 21:10:19 INFO - "repo_path": "integration/fx-team", 21:10:19 INFO - "revision": "493d6820745e4e3ed22e48a5f9229ea033a64a3a", 21:10:19 INFO - "stage_platform": "linux64-pgo", 21:10:19 INFO - "builduid": "92f548a05d6e4c959339d5b9fa7abbe6", 21:10:19 INFO - "slavebuilddir": "test" 21:10:19 INFO - } 21:10:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:10:19 INFO - Running post-action listener: _resource_record_post_action 21:10:19 INFO - ##### 21:10:19 INFO - ##### Running download-and-extract step. 21:10:19 INFO - ##### 21:10:19 INFO - Running pre-action listener: _resource_record_pre_action 21:10:19 INFO - Running main action method: download_and_extract 21:10:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:19 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json 21:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json 21:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:10:21 INFO - Downloaded 1448 bytes. 21:10:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:10:21 INFO - Using the following test package requirements: 21:10:21 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:21 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:10:21 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:10:21 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'jsshell-linux-x86_64.zip'], 21:10:21 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:10:21 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:21 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:10:21 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:10:21 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:10:21 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:10:21 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:10:21 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:10:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:21 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:10:32 INFO - Downloaded 22486116 bytes. 21:10:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:33 INFO - Return code: 0 21:10: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 21:10: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')]} 21:10:33 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:10:39 INFO - Downloaded 22486116 bytes. 21:10:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:40 INFO - Return code: 0 21:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:40 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:10:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:10:42 INFO - Downloaded 11132144 bytes. 21:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:10:42 INFO - Return code: 0 21:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:42 INFO - https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:10:44 INFO - Downloaded 55947012 bytes. 21:10:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:44 INFO - mkdir: /builds/slave/test-pgo/properties 21:10:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:10:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:10:44 INFO - Contents: 21:10:44 INFO - build_url:https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:10:44 INFO - Running post-action listener: _resource_record_post_action 21:10:44 INFO - Running post-action listener: set_extra_try_arguments 21:10:44 INFO - ##### 21:10:44 INFO - ##### Running populate-webroot step. 21:10:44 INFO - ##### 21:10:44 INFO - Running pre-action listener: _resource_record_pre_action 21:10:44 INFO - Running main action method: populate_webroot 21:10:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:10:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:10:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:10:44 INFO - '--tppagecycles', 21:10:44 INFO - '7'], 21:10:44 INFO - 'tests': ['tsvgm']}}, 21:10:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:10:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:10:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:10:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'tests': ['damp', 'tps']}, 21:10:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['damp', 'tps']}, 21:10:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:10:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:10:44 INFO - 'other': {'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'other_l64': {'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'other_nol64': {'tests': ['a11yr', 21:10:44 INFO - 'ts_paint', 21:10:44 INFO - 'tpaint', 21:10:44 INFO - 'sessionrestore', 21:10:44 INFO - 'sessionrestore_no_auto_restore']}, 21:10:44 INFO - 'svgr': {'tests': ['tsvgx', 21:10:44 INFO - 'tsvgr_opacity', 21:10:44 INFO - 'tart', 21:10:44 INFO - 'tscrollx', 21:10:44 INFO - 'cart']}, 21:10:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['tsvgx', 21:10:44 INFO - 'tsvgr_opacity', 21:10:44 INFO - 'tart', 21:10:44 INFO - 'tscrollx', 21:10:44 INFO - 'cart']}, 21:10:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'tests': ['tp5o']}, 21:10:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'talos_options': ['--e10s'], 21:10:44 INFO - 'tests': ['tp5o']}, 21:10:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'talos_options': ['--xperf_path', 21:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:44 INFO - 'tests': ['tp5n']}, 21:10:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:44 INFO - 'talos_options': ['--e10s', 21:10:44 INFO - '--xperf_path', 21:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:44 INFO - 'tests': ['tp5n']}}, 21:10:44 INFO - 'talos.zip': {'path': '', 21:10:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:10:44 INFO - Running post-action listener: _resource_record_post_action 21:10:44 INFO - ##### 21:10:44 INFO - ##### Running create-virtualenv step. 21:10:44 INFO - ##### 21:10:44 INFO - Running pre-action listener: _resource_record_pre_action 21:10:44 INFO - Running main action method: create_virtualenv 21:10:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:10:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:10:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:10:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:10:44 INFO - Using real prefix '/usr' 21:10:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 21:10:46 INFO - Installing pip.................done. 21:10:46 INFO - Return code: 0 21:10:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:10:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:10:46 INFO - Using env: {'DISPLAY': ':0', 21:10:46 INFO - 'HOME': '/home/cltbld', 21:10:46 INFO - 'LANG': 'en_US.UTF-8', 21:10:46 INFO - 'LANGUAGE': 'en_US:en', 21:10:46 INFO - 'LOGNAME': 'cltbld', 21:10:46 INFO - 'MAIL': '/var/mail/cltbld', 21:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:46 INFO - 'MOZ_NO_REMOTE': '1', 21:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:46 INFO - 'NO_EM_RESTART': '1', 21:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:46 INFO - 'SHELL': '/bin/bash', 21:10:46 INFO - 'SHLVL': '1', 21:10:46 INFO - 'TERM': 'linux', 21:10:46 INFO - 'TMOUT': '86400', 21:10:46 INFO - 'USER': 'cltbld', 21:10:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:46 INFO - '_': '/tools/buildbot/bin/python'} 21:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:10:47 INFO - Cleaning up... 21:10:47 INFO - Return code: 0 21:10:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:10: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')]} 21:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:10:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:10:47 INFO - Using env: {'DISPLAY': ':0', 21:10:47 INFO - 'HOME': '/home/cltbld', 21:10:47 INFO - 'LANG': 'en_US.UTF-8', 21:10:47 INFO - 'LANGUAGE': 'en_US:en', 21:10:47 INFO - 'LOGNAME': 'cltbld', 21:10:47 INFO - 'MAIL': '/var/mail/cltbld', 21:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:47 INFO - 'MOZ_NO_REMOTE': '1', 21:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:47 INFO - 'NO_EM_RESTART': '1', 21:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:47 INFO - 'SHELL': '/bin/bash', 21:10:47 INFO - 'SHLVL': '1', 21:10:47 INFO - 'TERM': 'linux', 21:10:47 INFO - 'TMOUT': '86400', 21:10:47 INFO - 'USER': 'cltbld', 21:10:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:47 INFO - '_': '/tools/buildbot/bin/python'} 21:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:47 INFO - Downloading/unpacking psutil>=0.7.1 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:49 INFO - Installing collected packages: psutil 21:10:49 INFO - Running setup.py install for psutil 21:10:49 INFO - building 'psutil._psutil_linux' extension 21:10:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:10:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:10:49 INFO - building 'psutil._psutil_posix' extension 21:10:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:10:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:49 INFO - Successfully installed psutil 21:10:49 INFO - Cleaning up... 21:10:49 INFO - Return code: 0 21:10:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:10: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')]} 21:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:10:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:10:49 INFO - Using env: {'DISPLAY': ':0', 21:10:49 INFO - 'HOME': '/home/cltbld', 21:10:49 INFO - 'LANG': 'en_US.UTF-8', 21:10:49 INFO - 'LANGUAGE': 'en_US:en', 21:10:49 INFO - 'LOGNAME': 'cltbld', 21:10:49 INFO - 'MAIL': '/var/mail/cltbld', 21:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:49 INFO - 'MOZ_NO_REMOTE': '1', 21:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:49 INFO - 'NO_EM_RESTART': '1', 21:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:49 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:49 INFO - 'SHELL': '/bin/bash', 21:10:49 INFO - 'SHLVL': '1', 21:10:49 INFO - 'TERM': 'linux', 21:10:49 INFO - 'TMOUT': '86400', 21:10:49 INFO - 'USER': 'cltbld', 21:10:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:49 INFO - '_': '/tools/buildbot/bin/python'} 21:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:10:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:10:51 INFO - Installing collected packages: mozsystemmonitor 21:10:51 INFO - Running setup.py install for mozsystemmonitor 21:10:51 INFO - Successfully installed mozsystemmonitor 21:10:51 INFO - Cleaning up... 21:10:51 INFO - Return code: 0 21:10:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:10:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:10:51 INFO - Using env: {'DISPLAY': ':0', 21:10:51 INFO - 'HOME': '/home/cltbld', 21:10:51 INFO - 'LANG': 'en_US.UTF-8', 21:10:51 INFO - 'LANGUAGE': 'en_US:en', 21:10:51 INFO - 'LOGNAME': 'cltbld', 21:10:51 INFO - 'MAIL': '/var/mail/cltbld', 21:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:51 INFO - 'MOZ_NO_REMOTE': '1', 21:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:51 INFO - 'NO_EM_RESTART': '1', 21:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:51 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:51 INFO - 'SHELL': '/bin/bash', 21:10:51 INFO - 'SHLVL': '1', 21:10:51 INFO - 'TERM': 'linux', 21:10:51 INFO - 'TMOUT': '86400', 21:10:51 INFO - 'USER': 'cltbld', 21:10:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:51 INFO - '_': '/tools/buildbot/bin/python'} 21:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:10:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:10:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:54 INFO - Downloading docopt-0.6.1.tar.gz 21:10:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:10:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:10:54 INFO - Running setup.py install for blobuploader 21:10:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:10:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:10:54 INFO - Running setup.py install for requests 21:10:55 INFO - Running setup.py install for docopt 21:10:55 INFO - Successfully installed blobuploader requests docopt 21:10:55 INFO - Cleaning up... 21:10:55 INFO - Return code: 0 21:10:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:10:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:10:55 INFO - Using env: {'DISPLAY': ':0', 21:10:55 INFO - 'HOME': '/home/cltbld', 21:10:55 INFO - 'LANG': 'en_US.UTF-8', 21:10:55 INFO - 'LANGUAGE': 'en_US:en', 21:10:55 INFO - 'LOGNAME': 'cltbld', 21:10:55 INFO - 'MAIL': '/var/mail/cltbld', 21:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:55 INFO - 'MOZ_NO_REMOTE': '1', 21:10:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:55 INFO - 'NO_EM_RESTART': '1', 21:10:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:55 INFO - 'SHELL': '/bin/bash', 21:10:55 INFO - 'SHLVL': '1', 21:10:55 INFO - 'TERM': 'linux', 21:10:55 INFO - 'TMOUT': '86400', 21:10:55 INFO - 'USER': 'cltbld', 21:10:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:55 INFO - '_': '/tools/buildbot/bin/python'} 21:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:55 INFO - Running setup.py (path:/tmp/pip-esCVKD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:55 INFO - Running setup.py (path:/tmp/pip-reJnDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:55 INFO - Running setup.py (path:/tmp/pip-3Mo_qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:55 INFO - Running setup.py (path:/tmp/pip-VL5f6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:55 INFO - Running setup.py (path:/tmp/pip-kT00gx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:55 INFO - Running setup.py (path:/tmp/pip-rHo5po-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:55 INFO - Running setup.py (path:/tmp/pip-pihoh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:55 INFO - Running setup.py (path:/tmp/pip-axcZIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:56 INFO - Running setup.py (path:/tmp/pip-WvOTos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:56 INFO - Running setup.py (path:/tmp/pip-WowqtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:56 INFO - Running setup.py (path:/tmp/pip-HNRbqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:56 INFO - Running setup.py (path:/tmp/pip-pRV4Er-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:56 INFO - Running setup.py (path:/tmp/pip-TfZHya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:56 INFO - Running setup.py (path:/tmp/pip-HVM4GH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:56 INFO - Running setup.py (path:/tmp/pip-G8qgJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:56 INFO - Running setup.py (path:/tmp/pip-p5fD63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:56 INFO - Running setup.py (path:/tmp/pip-djv37I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:10:56 INFO - Running setup.py install for manifestparser 21:10:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:10:56 INFO - Running setup.py install for mozcrash 21:10:56 INFO - Running setup.py install for mozdebug 21:10:56 INFO - Running setup.py install for mozdevice 21:10:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for mozfile 21:10:57 INFO - Running setup.py install for mozhttpd 21:10:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for mozinfo 21:10:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for mozInstall 21:10:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for mozleak 21:10:57 INFO - Running setup.py install for mozlog 21:10:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for moznetwork 21:10:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:10:57 INFO - Running setup.py install for mozprocess 21:10:57 INFO - Running setup.py install for mozprofile 21:10:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:10:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:10:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:10:58 INFO - Running setup.py install for mozrunner 21:10:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:10:58 INFO - Running setup.py install for mozscreenshot 21:10:58 INFO - Running setup.py install for moztest 21:10:58 INFO - Running setup.py install for mozversion 21:10:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:10:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:10:58 INFO - Cleaning up... 21:10:58 INFO - Return code: 0 21:10:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:10:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:10:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:10:58 INFO - Using env: {'DISPLAY': ':0', 21:10:58 INFO - 'HOME': '/home/cltbld', 21:10:58 INFO - 'LANG': 'en_US.UTF-8', 21:10:58 INFO - 'LANGUAGE': 'en_US:en', 21:10:58 INFO - 'LOGNAME': 'cltbld', 21:10:58 INFO - 'MAIL': '/var/mail/cltbld', 21:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:58 INFO - 'MOZ_NO_REMOTE': '1', 21:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:10:58 INFO - 'NO_EM_RESTART': '1', 21:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:10:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:10:58 INFO - 'SHELL': '/bin/bash', 21:10:58 INFO - 'SHLVL': '1', 21:10:58 INFO - 'TERM': 'linux', 21:10:58 INFO - 'TMOUT': '86400', 21:10:58 INFO - 'USER': 'cltbld', 21:10:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:58 INFO - '_': '/tools/buildbot/bin/python'} 21:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:58 INFO - Running setup.py (path:/tmp/pip-TykM9q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:58 INFO - Running setup.py (path:/tmp/pip-MfhOX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:58 INFO - Running setup.py (path:/tmp/pip-tWM4sb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:58 INFO - Running setup.py (path:/tmp/pip-WiHyua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:10:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:58 INFO - Running setup.py (path:/tmp/pip-uioVZJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:59 INFO - Running setup.py (path:/tmp/pip-HqPGmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:59 INFO - Running setup.py (path:/tmp/pip-JsoY6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:59 INFO - Running setup.py (path:/tmp/pip-5ELCPi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:59 INFO - Running setup.py (path:/tmp/pip-zATXpY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:59 INFO - Running setup.py (path:/tmp/pip-4HO5gs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:59 INFO - Running setup.py (path:/tmp/pip-RF5EJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:59 INFO - Running setup.py (path:/tmp/pip-s6vvfk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:59 INFO - Running setup.py (path:/tmp/pip-xJz6bd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:59 INFO - Running setup.py (path:/tmp/pip-cAIZJ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:59 INFO - Running setup.py (path:/tmp/pip-1HyRSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:59 INFO - Running setup.py (path:/tmp/pip-IzhSwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:10:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:59 INFO - Running setup.py (path:/tmp/pip-F8JlKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:10: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:10:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:01 INFO - Downloading blessings-1.6.tar.gz 21:11:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:11:01 INFO - Installing collected packages: blessings 21:11:01 INFO - Running setup.py install for blessings 21:11:01 INFO - Successfully installed blessings 21:11:01 INFO - Cleaning up... 21:11:01 INFO - Return code: 0 21:11:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:11:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:11:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:11:02 INFO - Reading from file tmpfile_stdout 21:11:02 INFO - Current package versions: 21:11:02 INFO - argparse == 1.2.1 21:11:02 INFO - blessings == 1.6 21:11:02 INFO - blobuploader == 1.2.4 21:11:02 INFO - docopt == 0.6.1 21:11:02 INFO - manifestparser == 1.1 21:11:02 INFO - mozInstall == 1.12 21:11:02 INFO - mozcrash == 0.16 21:11:02 INFO - mozdebug == 0.1 21:11:02 INFO - mozdevice == 0.48 21:11:02 INFO - mozfile == 1.2 21:11:02 INFO - mozhttpd == 0.7 21:11:02 INFO - mozinfo == 0.9 21:11:02 INFO - mozleak == 0.1 21:11:02 INFO - mozlog == 3.1 21:11:02 INFO - moznetwork == 0.27 21:11:02 INFO - mozprocess == 0.22 21:11:02 INFO - mozprofile == 0.28 21:11:02 INFO - mozrunner == 6.11 21:11:02 INFO - mozscreenshot == 0.1 21:11:02 INFO - mozsystemmonitor == 0.0 21:11:02 INFO - moztest == 0.7 21:11:02 INFO - mozversion == 1.4 21:11:02 INFO - psutil == 3.1.1 21:11:02 INFO - requests == 1.2.3 21:11:02 INFO - wsgiref == 0.1.2 21:11:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:11:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:11:02 INFO - Using env: {'DISPLAY': ':0', 21:11:02 INFO - 'HOME': '/home/cltbld', 21:11:02 INFO - 'LANG': 'en_US.UTF-8', 21:11:02 INFO - 'LANGUAGE': 'en_US:en', 21:11:02 INFO - 'LOGNAME': 'cltbld', 21:11:02 INFO - 'MAIL': '/var/mail/cltbld', 21:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:02 INFO - 'MOZ_NO_REMOTE': '1', 21:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:02 INFO - 'NO_EM_RESTART': '1', 21:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:02 INFO - 'SHELL': '/bin/bash', 21:11:02 INFO - 'SHLVL': '1', 21:11:02 INFO - 'TERM': 'linux', 21:11:02 INFO - 'TMOUT': '86400', 21:11:02 INFO - 'USER': 'cltbld', 21:11:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:02 INFO - '_': '/tools/buildbot/bin/python'} 21:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:11:02 INFO - Cleaning up... 21:11:02 INFO - Return code: 0 21:11:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:11:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:11:02 INFO - Using env: {'DISPLAY': ':0', 21:11:02 INFO - 'HOME': '/home/cltbld', 21:11:02 INFO - 'LANG': 'en_US.UTF-8', 21:11:02 INFO - 'LANGUAGE': 'en_US:en', 21:11:02 INFO - 'LOGNAME': 'cltbld', 21:11:02 INFO - 'MAIL': '/var/mail/cltbld', 21:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:02 INFO - 'MOZ_NO_REMOTE': '1', 21:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:02 INFO - 'NO_EM_RESTART': '1', 21:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:02 INFO - 'SHELL': '/bin/bash', 21:11:02 INFO - 'SHLVL': '1', 21:11:02 INFO - 'TERM': 'linux', 21:11:02 INFO - 'TMOUT': '86400', 21:11:02 INFO - 'USER': 'cltbld', 21:11:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:02 INFO - '_': '/tools/buildbot/bin/python'} 21:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:02 INFO - Downloading/unpacking jsonschema 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:11:04 INFO - Downloading/unpacking functools32 (from jsonschema) 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:11:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:11:04 INFO - warning: no files found matching '*.txt' 21:11:04 INFO - no previously-included directories found matching 'build' 21:11:04 INFO - no previously-included directories found matching 'dist' 21:11:04 INFO - no previously-included directories found matching '.git*' 21:11:04 INFO - Installing collected packages: jsonschema, functools32 21:11:04 INFO - Running setup.py install for functools32 21:11:04 INFO - warning: no files found matching '*.txt' 21:11:04 INFO - no previously-included directories found matching 'build' 21:11:04 INFO - no previously-included directories found matching 'dist' 21:11:04 INFO - no previously-included directories found matching '.git*' 21:11:04 INFO - Successfully installed jsonschema functools32 21:11:04 INFO - Cleaning up... 21:11:04 INFO - Return code: 0 21:11:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:11:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabd7f0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, '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': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:11:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:11:04 INFO - Using env: {'DISPLAY': ':0', 21:11:04 INFO - 'HOME': '/home/cltbld', 21:11:04 INFO - 'LANG': 'en_US.UTF-8', 21:11:04 INFO - 'LANGUAGE': 'en_US:en', 21:11:04 INFO - 'LOGNAME': 'cltbld', 21:11:04 INFO - 'MAIL': '/var/mail/cltbld', 21:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:04 INFO - 'MOZ_NO_REMOTE': '1', 21:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:04 INFO - 'NO_EM_RESTART': '1', 21:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:04 INFO - 'SHELL': '/bin/bash', 21:11:04 INFO - 'SHLVL': '1', 21:11:04 INFO - 'TERM': 'linux', 21:11:04 INFO - 'TMOUT': '86400', 21:11:04 INFO - 'USER': 'cltbld', 21:11:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:04 INFO - '_': '/tools/buildbot/bin/python'} 21:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:11:04 INFO - Downloading/unpacking flake8 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11: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 21:11:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:11:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:11:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:11:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:11:07 INFO - no previously-included directories found matching 'docs/_build' 21:11:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:11:07 INFO - Running setup.py install for pep8 21:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:11:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:11:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:11:07 INFO - no previously-included directories found matching 'docs/_build' 21:11:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:11:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:11:07 INFO - Cleaning up... 21:11:07 INFO - Return code: 0 21:11:07 INFO - Running post-action listener: _resource_record_post_action 21:11:07 INFO - Running post-action listener: _start_resource_monitoring 21:11:07 INFO - Starting resource monitoring. 21:11:07 INFO - ##### 21:11:07 INFO - ##### Running install step. 21:11:07 INFO - ##### 21:11:07 INFO - Running pre-action listener: _resource_record_pre_action 21:11:07 INFO - Running main action method: install 21:11:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:11:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:11:07 INFO - Reading from file tmpfile_stdout 21:11:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:11:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:11:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:11:07 INFO - Reading from file tmpfile_stdout 21:11:07 INFO - Output received: 21:11:07 INFO - Usage: mozinstall [options] installer 21:11:07 INFO - Options: 21:11:07 INFO - -h, --help show this help message and exit 21:11:07 INFO - -d DEST, --destination=DEST 21:11:07 INFO - Directory to install application into. [default: 21:11:07 INFO - "/builds/slave/test-pgo"] 21:11:07 INFO - --app=APP Application being installed. [default: firefox] 21:11:07 INFO - mkdir: /builds/slave/test-pgo/build/application 21:11:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:11:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:11:24 INFO - Reading from file tmpfile_stdout 21:11:24 INFO - Output received: 21:11:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:11:24 INFO - Running post-action listener: _resource_record_post_action 21:11:24 INFO - ##### 21:11:24 INFO - ##### Running run-tests step. 21:11:24 INFO - ##### 21:11:24 INFO - Running pre-action listener: _resource_record_pre_action 21:11:24 INFO - Running main action method: run_tests 21:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:11:24 INFO - Python 2.7.3 21:11:24 INFO - Return code: 0 21:11:24 INFO - grabbing minidump binary from tooltool 21:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:24 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 0x2b7a540>, '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 0x2b7b440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:11:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:11:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:11:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:24 INFO - Return code: 0 21:11:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:11:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:11:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:11:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:11:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:11:25 INFO - Return code: 0 21:11:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:11:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:11:25 INFO - Using env: {'DISPLAY': ':0', 21:11:25 INFO - 'HOME': '/home/cltbld', 21:11:25 INFO - 'LANG': 'en_US.UTF-8', 21:11:25 INFO - 'LANGUAGE': 'en_US:en', 21:11:25 INFO - 'LOGNAME': 'cltbld', 21:11:25 INFO - 'MAIL': '/var/mail/cltbld', 21:11:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:11:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:25 INFO - 'MOZ_NO_REMOTE': '1', 21:11:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:11:25 INFO - 'NO_EM_RESTART': '1', 21:11:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:11:25 INFO - 'PWD': '/builds/slave/test-pgo', 21:11:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:11:25 INFO - 'SHELL': '/bin/bash', 21:11:25 INFO - 'SHLVL': '1', 21:11:25 INFO - 'TERM': 'linux', 21:11:25 INFO - 'TMOUT': '86400', 21:11:25 INFO - 'USER': 'cltbld', 21:11:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017', 21:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:25 INFO - '_': '/tools/buildbot/bin/python'} 21:11:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:11:25 INFO - mozversion application_buildid: 20160120185004 21:11:25 INFO - mozversion application_changeset: 493d6820745e4e3ed22e48a5f9229ea033a64a3a 21:11:25 INFO - mozversion application_display_name: Nightly 21:11:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:25 INFO - mozversion application_name: Firefox 21:11:25 INFO - mozversion application_remotingname: firefox 21:11:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:11:25 INFO - mozversion application_vendor: Mozilla 21:11:25 INFO - mozversion application_version: 46.0a1 21:11:25 INFO - mozversion platform_buildid: 20160120185004 21:11:25 INFO - mozversion platform_changeset: 493d6820745e4e3ed22e48a5f9229ea033a64a3a 21:11:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:11:25 INFO - mozversion platform_version: 46.0a1 21:11:25 INFO - using testdate: 1453353085 21:11:25 INFO - actual date: 1453353085 21:11:25 INFO - starting webserver on 'localhost:33173' 21:11:25 INFO - SUITE-START | Running 3 tests 21:11:25 INFO - TEST-START | dromaeo_css 21:11:25 INFO - operating with platform_type : linux_ 21:11:25 INFO - Initialising browser for dromaeo_css test... 21:11:25 INFO - TEST-INFO | started process 6997 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH6EH9c/profile http://localhost:33173/getInfo.html) 21:11:29 INFO - PROCESS | 6997 | __metrics Screen width/height:1600/1200 21:11:29 INFO - PROCESS | 6997 | colorDepth:24 21:11:29 INFO - PROCESS | 6997 | Browser inner width/height: 1024/697 21:11:29 INFO - PROCESS | 6997 | __metrics 21:11:29 INFO - PROCESS | 6997 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:11:29 INFO - PROCESS | 6997 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:11:30 INFO - TEST-INFO | 6997: exit 0 21:11:30 INFO - Browser initialized. 21:11:30 INFO - Running cycle 1/1 for dromaeo_css test... 21:11:30 INFO - TEST-INFO | started process 7091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpH6EH9c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:11:42 INFO - PROCESS | 7091 | RSS: Main: 148406272 21:11:42 INFO - PROCESS | 7091 | 21:12:34 INFO - PROCESS | 7091 | 1453353154198 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:14:42 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33173/tests/dromaeo/cssquery-ext.html) 21:14:43 INFO - PROCESS | 7091 | RSS: Main: 231219200 21:14:43 INFO - PROCESS | 7091 | 21:17:45 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-ext.html (next: http://localhost:33173/tests/dromaeo/cssquery-jquery.html) 21:17:46 INFO - PROCESS | 7091 | RSS: Main: 230178816 21:17:46 INFO - PROCESS | 7091 | 21:20:48 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33173/tests/dromaeo/cssquery-mootools.html) 21:20:48 INFO - PROCESS | 7091 | RSS: Main: 221581312 21:20:48 INFO - PROCESS | 7091 | 21:23:50 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33173/tests/dromaeo/cssquery-prototype.html) 21:23:51 INFO - PROCESS | 7091 | RSS: Main: 211927040 21:23:51 INFO - PROCESS | 7091 | 21:26:54 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33173/tests/dromaeo/cssquery-yui.html) 21:26:54 INFO - PROCESS | 7091 | RSS: Main: 213843968 21:26:54 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | Cycle 1(1): loaded http://localhost:33173/tests/dromaeo/cssquery-yui.html (next: http://localhost:33173/tests/dromaeo/cssquery-dojo.html) 21:29:57 INFO - PROCESS | 7091 | RSS: Main: 259809280 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | __start_tp_report 21:29:57 INFO - PROCESS | 7091 | _x_x_mozilla_page_load 21:29:57 INFO - PROCESS | 7091 | _x_x_mozilla_page_load_details 21:29:57 INFO - PROCESS | 7091 | |i|pagename|runs| 21:29:57 INFO - PROCESS | 7091 | |0;dojo.html;3114.8442577871106;3159;3202.7437804975602;3210.5826242588473;3240.85416156273;5143;5170.14692575725;5237.3715154181555;5245.659032162912;5258.579313654908;5261.8947621047655;5280.867978300545;5292.497212764782;5305.814296499613;5328.254044433773;4697.53024697531;4701.271302948048;4721.787519561611;4766.380370551823;4830.323754674331;4742.241241401376;4782.713037217778;4792.496787837279;4848.854534363974;4858.611311095122;4695.3426520287185;4737.810487580493;4786.545278198548;4810.759462026919;4813.638977076698;4740.312654665088;4778.092162489151;4778.880527986794;4780.4741478437345;4809.302651115604;4654.4647365553055;4735.195016847144;4751.1922973094315;4783.641226907961;4823.059503396804;5014.974925125351;5043.5460808527405;5086.821961231339;5108.106081435734;5139.203423469331;5571.721413929287;5579.888402231933;5581.525570326487;5586.692731899744;5625.043742563774;5522.088855338864;5625.043742563774;5654.37801841797;5656.91514627281;5664.801731939404;5248.580113590903;5288.471152884719;5304.416514183436;5304.496072873109;5353.063213937546;5683.8010669626365;5684.54523638108;5685.260916080883;5688.744006519716;5692.601517893708;5448.509634132947;5516.172574113915;5524.226608274845;5530.336359636869;5531.502164805187;5587.664740115525;5624.3250809903075;5628.071368224197;5632.915506267409;5657.547396208293;5553.194786755897;5579.776808927679;5592.720363981784;5599.692016939108;5599.824036952205;5510.889782204334;5559.833205003856;5575.191597218381;5580.414056524007;5587.99416105105;4401.163778882003;4401.911961760747;4409.4267745193565;4432.135733531994;4446.133004064176;3899.707521935866;3924.2151569686175;3925.9803700981884;3958.050067983663;3972.5828787977425;5111.923321150186;5162.174052151638;5199.168133098686;5228.6339956203465;5268.6575372600655;5512.4211957744665;5548.778048878;5554.50009499147;5581.916271255935;5589.776408943597;5140.614453915971;5155.510226528474;5161.122609156452;5170.767315470737;5181.663191892515;4713.363695901078;4789.568938795525;4808.543188397167;4829.9034019319415;4892.143874821963;5727.8568035799435;5730.885382292331;5731.312242530923;5736.6558006519745;5745.569082318842;5453.672779633234;5574.693391863487;5582.385937546947;5584;5626.24045753818;5653.604247702621;5705.058665320342;5747.9137812932;5753.9136912945505;5779.248697669276;5571.8885622288135;5577.247071645276;5584.218209450599;5588.022096133079;5593.133064375028;5607.943920560742;5612.663240205601;5659.26429564154;5683.573731970201;5686.2607860977805;5326.707031113326;5419.160030195326;5431.402545720047;5463.453654634504;5520.558355331484;5462.289902312833;5478.150886612581;5483.095289277384;5485.588580856372;5487.780488780564;5275.472452754694;5367;5382.650127741685;5383.26972010185;5436.157395603688;5445.292112025411;5463.262459568066;5467.316585426822;5487.341519017744;5532.1425179097305;5335.733213339395;5337.466253374631;5339.7597108131;5345.1714984177515;5384.326959130109 21:29:57 INFO - PROCESS | 7091 | |1;ext.html;513.7765072193596;516.6977318268813;546.0144439287086;546.5682111132206;568.6616463204393;29197.85401072994;35280.64719352806;35495.99999999997;35547.2890542189;35591.11022224445;38037.809810950974;38480.807595962055;38496.80751596245;38530.036749081286;38594.421083683694;8457.407981441285;8741.169588889044;8749.4750314981;8760.4305720128;8762.649494020232;8454.196851299148;8554.230119289263;8581.270591999688;8588.527630980294;8597.140285971383;8560.957195214047;8602.48385096893;8608.870866937;8642.092580279075;8661.523616201106;8529.360297977646;8612.827743445096;8617.870731939025;8620.568971551429;8625.309975201968;8102.5543595102245;8179.631916563769;8181.059178194524;8195.34437245019;8491.872621910676;37359.81320093382;37751.43372849409;37773.81113094444;37831.81084094562;37910.43134352987;3222.226665600239;3269.8038117713013;3338.21551935295;3340.048086295394;3424.6917777399904;28642.856785716147;28644.570331445044;28875.133745987652;29035.56446653302;29910;3755.8732280558233;3781.829817658212;3894.941575876364;3923.4114882767526;4000.7799571023584;249529;249622;249727;274241;276981;53601;54403.72798136063;54773.72613136909;54774.605428267474;54807;50468;50683.23975140376;50728;50848.23727644089;50869.676077533826;12213.145079844326;12409.255444673348;12463;12611.684707882192;12817.23096614206;8968.506732129665;8980.640774368952;8998.10018998108;9126.087391260953;9215.078492150866;17372.47882563525;17491.125443727764;17502;17610.119494025246;17666.911665441592;7363.410927125817;7500.249975002456;7516.534275816272;7531.849363012709;7554.093508778982;892.2014796756866;985.5959056786683;1044.300318786415;1048.0567489259574;1063.2025980514613;27328.59007114895;27333.316667083483;27489.450210995667;27644.308892277855;27689.723102768716;966.12083004467;978.848278516831;981.288565789811;1108.6958679490717;1121.114319687454;14190.749422713456;14601.269936503133;14607.78088328676;15127.697446051017;15261.465848695243;252320;255474;256087;256234;256848.45212382966;45484.317735234;45519.317210241876;45707.771461143144;45742;45765;1310.6657802260363;1323.6690827293178;1337.224409842289;1344.5294147048455;1346.199011588123;25536.616950746124;28164;28487.572686409305;28668.42663146767;28789.28026799347;43581.128377432906;43802.78098609487;43841.34237986497;44001;44071.118577627625;290296;294939;298627;303149;409772;30320.69679303267;30338.241543961576;30393;30608.540871887384;30818.84590577033;38970;39815.80092099637;39824.40263395994;40291;40351.59648403478;33469.33061338808;33612.66387336193;34225.65774342225;34314.14214644654;34337.828310858284;34364;34812.82593587016;35006.29987400187;35083;35252;31338.21654458657;31368.686313136575;31499.84250078735;31536.526952096196;33749.662503375635;27534;28029.299267518476;29178.270543236587;29339.266518336357;29503.85248073746;22253.666195007412;22904.198353057564;23027.194048208232;23096.191633292754;24352.391190219678 21:29:57 INFO - PROCESS | 7091 | |2;jquery.html;362.09115121046165;364.3369068295702;366.7249562827879;366.8514251728051;371.58568196460953;13670.179789212629;13742.244176570284;15979.920100399497;16521.091339976298;17337;15374.923125384385;15820.841791582081;16118;16716.83283167168;16726.498205053867;4818.3736114305175;4974.676646018015;5018.34761481007;5033.11920413928;5035.672681275723;3795.430685397185;3908.413737939318;5046.848594542152;5105.948940510603;6553.311902250267;6520.152380190569;6700.463962882982;6783.253842077367;6783.898241526381;6784.525083244175;6580.703868325937;6604.24051234107;6605.504587155934;6630.138082049351;6665.93334066658;6190.2571691397325;6552.246491653474;6553.475721942281;6555.278919318871;6557.114789503404;21407.785922140734;21813.23653672114;22677.319680409615;22790.430239244153;22794.544109117724;2131.2753663754243;2138.379869837745;2149;2228.3092241405216;2279.578278018572;13350.93192544594;13360.732785344337;13772.793408098887;14047.367868445945;14268.286585670676;1822.4168266154836;1848.667239896818;1863.4782260966952;1904.5333893196255;1974.7827738948704;58340.708296458244;59862;61477;61563;61881;14669.33987970544;14713.164673229438;14823.851761482463;14911.328990195467;15110.39558417673;23074.077036918672;23148.65277020846;23334.416639584146;23383.661633836822;23390.766092338858;8099.271065604124;8117.594120293962;8169.060558035783;8176.877346839802;8206.794830129294;6668;6670.266270710218;6687.331266873371;6745;6751.831204219836;6660.8667826643195;7419.332260096618;7447.3669738071785;7460.888086678704;7580.9620951894885;2615.594582839663;2974.1523665755158;2984.701529846998;3001.2046807596003;3057.4955132402906;417.2572820379729;420.2939062375239;426.62670163606845;434.6566212692001;832.908889354947;10721.463926803628;11072.944635276772;11197.216194866443;11378.146639002109;11569.479373428216;452.3508764922347;453.95687409696023;454.27543068805204;460.537160154043;482.66937148053694;6094.634321940698;6151.876962460815;6300.684965751694;6308.3060863305;9335.953320233355;383789;392743;456087;529644;597184;44772;45274.09451810945;46249;48880.75559622179;74054;1022.5040855185377;1104.6851647280487;1125.954961801535;1126.7915435644431;1136.335243882338;11931.403429828648;14339.426422943383;14492.275386230436;14637.487687930872;14789.855470956867;30521;31268.37463250768;31659.683403165673;31786.517415420964;33838;41459;42578.78710606427;44221.778891105336;44389.77805110954;44510.554894450644;7419.888701669587;7631.771046868603;7666.233376662289;7687;7817.921820781947;10130.493475326057;10729.9463502682;11566.94216528912;11599.420028998686;11844.348560829238;8703.347248956226;9170.649928650675;9549.379290346105;9808.313418060667;9905.306628535933;9446.480443575669;9507.286953478379;9622.113191349137;9987.450690212108;10259.179265658879;9259.953700231456;9733.853992189981;9772.413655180711;9799.902000979899;10392.740181495523;7131.108611423572;7204.171520275236;7207.5675459472595;7547.245275472628;7669.003029606339;8780.912190878265;9038.90961090407;9063.41087829289;9082.818343633222;9225.630974760934 21:29:57 INFO - PROCESS | 7091 | |3;mootools.html;1296.1121631682292;1465.2966576043498;1491.694202688449;1651.7852679151715;1787.436957358432;6975.058367120438;7503.362214211792;7648.961755191216;7650.0819901611885;7701.845963080735;7466.626668666572;7538.773836784905;7590.1650818409935;7592.392608591299;7630.198829122945;1984.8213660770527;2024.8076432738867;2267.093162734911;2272.71591051119;2298.092253559843;2346.2022912209845;2355.9411014724596;2356.4815740537056;2357.834951553392;2357.834951553392;2240.249516411996;2302.6085565453914;2303.1823702585593;2303.7696230376996;2304.1474654377903;2268.5803126421583;2296.7473577906417;2336.532693461306;2347.8708671023087;2356.4344557306295;2301.6547517872286;2307.065638416444;2307.596170670126;2322.3613506285737;2348.6007378745653;7894;7899.486533375312;7912.802179945547;7922.80192995174;7982.401319901031;4791.6166706663735;4824.372831531913;4876.658633895629;4889.511048895082;4894.755262236909;3103.968960310413;3153.369326134782;3195;3199.664035276309;3211.6948889855425;978.7699890525721;983.4001259231862;1012.8025035118155;1023.5803320638503;1024.6977141743203;11012.119030477543;11014.284071535405;11025.062869656089;11026.724331891766;11030.50362733679;4375.912481750347;4443.622292105143;4445.466544014739;4482.327650852399;4492.685512014193;9391.953040234892;9405.247580193569;9414.388064775767;9421.952890235505;9438.339316247797;4892.8532144035735;4904.239842824368;4940.629452790983;4943.826966056171;4949.7772600233075;4437.068215674744;4461.709988850715;4474.463064432289;4474.485434175046;4481.484629267676;3449.379111759907;3504.649535046526;3718.535183102112;3745.550533935945;3773.6226377362045;1180.15029178991;1182.1134149387958;1183.402381797187;1192.9045676345872;1205.1684337806885;1287.1504806827636;1296.0603562417361;1313.4089659653193;1330.9068365214537;1332.7534406134896;7191.137063552407;7230.096237970254;7283.963580182065;7289.052423184952;7304.452166087564;1072.0887245840972;1091.1489038549944;1096.8464414981909;1096.857408536885;1098.3464838421128;5741.167530708024;5824.446677565625;5827.475527202488;5832.24180856486;5841.386654401312;9133.40632858862;9335.346525743133;9471.10024547667;9484.715458536255;9632.13310802017;9407.106324899123;9416.529173541432;9502.287328450255;9504.667336643184;9524.8571271431;7239.9276007240305;7271.454640901953;7307.794213954744;7347.853042939111;7357.742479013209;6913.3777959983845;6939.826504337432;6998.740226759232;7004.579725216503;7037.683304251424;8022.27799498048;8415.158484151536;8454.40819142654;8477.406581539233;8609.053004169662;8773.034966153846;8819.647214111365;8823.911760882309;8828.42615230008;8828.514431706319;6180.567360284737;6379.6810159490915;6500.772472963424;6539.771108011197;6549.279579246374;6819.318068193141;6879.036934829028;7334.559926404433;7468.402527797872;7527.473076884785;6884.8967265490055;6967.860642787217;7037.190723066913;7276.05411296528;7343.118825740731;6918.204406493318;6949.270326615632;7058.964705176441;7078.646067696492;7210.206877243394;7158.6420678964805;7200.567965921852;7248.601326926859;7249.710011599477;7263.237360077116;6313.3686631336495;6420.101185834081;6427.389398007182;6447.258565264867;6466.224053113657;6590.47276217911;6595.736170553124;6600.438962688226;6619.371159739817;6622.867542649216 21:29:57 INFO - PROCESS | 7091 | |4;prototype.html;325.37040826001686;331.88549950267156;342.60600309643905;344.14308372153346;349.6486031538305;5744.224529688491;5874.530037596993;5890.911636325448;5909.645421274721;5911.113333000052;5644.915326270099;5807.651540907548;5818.563607729427;5854.648721076738;5858;4552.681312308131;4553.749543775091;4557.886052848672;4566.835456958471;4569.794359253841;4344.45694288214;4428.070105277896;4447.5552444755585;4474.127545128685;4551.931721024187;4418.955810441903;4498.122866041123;4504.279315309551;4508.143452743984;4538.863834084983;4515.61617262533;4518.254488009475;4525.592696657317;4526.705764125321;4530.433695788027;4004.4794176757127;4005.859794907193;4012.4382586437923;4019.035431496449;4020.336644453691;5463.836084917459;5603.579731520153;5626.12795016769;5658.292713410824;5660.801871934463;5176.249443830661;5203.349581302337;5207.427183009866;5208.661437006583;5212.4266330703595;5893.381194974551;6220.47125994291;6222.284437289724;6235.438810507031;6248.812535623893;4222.915541689149;4224.831006759757;4306.935395969063;4326.913461730779;4332.306830907071;6361.745530178788;6430.324815894357;6438.774642887476;6444.355564443518;6459.128017717595;4380.386745855582;4402.163588918095;4403.4495688039;4403.801828917706;4408.052268762167;4331.675124365685;4456.777161141995;4464.620507256855;4466.330050492452;4466.441694788152;5162.6128040397125;5168.2169651470185;5168.870778230575;5175.275461435402;5176.50823171798;6250.874982500324;6259.123722678829;6267.5299352548745;6275.780347687901;6277.5605707600025;1563.0231105559026;1567.0910871694389;1569.1212920764408;1570.348305453247;1570.7486802111607;1069.2835800014009;1074.0870260278857;1074.414444127952;1092.5575142067476;1103.5475455063386;5912.9113063304085;5921.496672782776;5926.851828704231;5928.644281343133;5932.40675932412;6449.290578036413;6451.774187903495;6454.903176452357;6460.3862633049785;6474;5862.208601838783;5889.793857215062;5891.705414729332;5899.7050147492455;5919.437653422918;3384.610769761509;3496.493008513751;3505.5618047744033;3505.702015328726;3510.24529726105;6705.430038446787;6708.865822683519;6716.899246511306;6717.16035495563;6761.357671021246;6619.3380661933425;6622.8344291393105;6628.436582890412;6631.303713110054;6631.933680663228;6498.935010649833;6667.899611622323;6672.966635166793;6679.198496180489;6680.198376194888;6188.907166392418;6368.395002474757;6461.386168314003;6465.3857883501;6473.579217350857;6232;6390.93609063922;6397.808065758035;6402.5518213726455;6421.935780642134;6679.799606011828;6683.298253683488;6683.665816709048;6685.732570697118;6695.598264104169;4316.201502722007;4452.799624016991;4487.282034874535;4490.236659767913;4491.865244042684;6441.935580644134;6456.257530384066;6465.127207827071;6466.708998095191;6468.902966455601;6228.719707613078;6230.190075290365;6232.906506402498;6283.96858015707;6291.937080629135;6172.530987604814;6206.255249369924;6218.378162183745;6275.058741188858;6280.8429789253805;6081.817545473643;6137.478314343331;6149.108379285068;6152.477039451518;6153.292371377349;6277.278113016879;6288.622682639057;6292.590981586182;6301.527385446201;6304.873902522016;6022.789202378071;6143.815685529441;6144.969275153596;6146.231721034871;6157.476614487819 21:29:57 INFO - PROCESS | 7091 | |5;yui.html;826.698255136875;853.5902766671993;853.6670698427611;853.6969375871565;861.164670269838;13178.868211317884;13319.667008324797;13338;13354.7329053419;13419.194848309096;13822.654433639163;14258.928705356484;14280.928595357034;14294.499692510764;14302.213378264192;776.4564804636763;788.03072221168;788.3850596534712;788.4126325887194;789.6130895861044;652.3346186889394;661.7452280871851;771.0477560213133;797.3461761355691;798.5967086621278;836.2348451167175;844.0167205205928;846.7417437681505;847.0259201917783;847.2755793796308;680.43863812355;690.1132045321788;842.2167384332569;843.641452382738;843.7763992541982;599.5353600959248;615.7229246838896;616.8272883592601;616.8827922694719;616.9228846394201;13604.38780254881;13705.588832334946;13711.45154193831;13720.108192967426;13773.586792396243;12226.572069977508;12726.80909786354;12795.232286062866;12973.41619627119;13062.346882655924;10223.539940702687;10246.436445995467;10331.173506119492;10380.221483388776;10409.479526023668;3593.4969104325414;3630.6913912317486;3672.485851980725;3678.521792167028;3741.4761933329355;47995;48097.27854082191;48161.5183848164;48470;48974.51025489735;9788.168005719594;9945.303828732063;10036.698899032895;10222.693319200436;10298.588056477807;18375.08124593765;18383;18396.98816565075;18407.53981150455;18446;7410.333070023724;7483.8877416838795;7538.472306938462;7558.13081495624;7643.656035478417;4321.67587430944;4335.82656693735;4362.083962367875;4375.715578487452;4433.8226470941445;3048.679888611708;3124.89062882798;3128.9843550782102;3134.4044631519937;3137.9215519611735;593.0333556303198;599.8620317327039;602.3825578781783;612.2897438970862;613.7544982007233;555.386298140557;641.6310621392718;670.6579644381303;675.5440077947366;687.1033301541437;8343.41596088268;8611.440256383315;8627.137286271323;8778.824423511494;9462.716118516455;570;576.6391316493157;582.5019608234983;627.9277883043509;673.8248055505604;3677.4667673187773;3957.960420395817;4166.106036368744;4222.239996800606;4241.236577416094;53990.73004634952;58347.70826145842;58400.41599584035;58579.70710146507;58716.11925821116;49744.75127624339;50080;50799.492005079475;50807;50880;44436.11127777426;44557.777211114386;45223.09553808905;46676.59970200899;46801.76599116983;8136.83726325482;8502.022267439077;8502.617382217939;8518.403711740119;8574.030122550206;35026.64973350336;35506;35852;36060.27879442449;36382.09044773902;42403.7879810599;45372.09255814799;45390.54609453863;45628.31557526573;45646.837676913194;10695.5187016586;10784.622538211124;10846.186536009673;10916.672499825017;11104.833427498756;11375.886241137483;11602.535898563963;11605.88394116048;11616.128790340927;11628.709282268012;10764.40795756241;10773.89226107729;10851.782964340828;10888.18338624622;10889.401082940198;10428.478576071015;10571.5242814072;10699.89300106989;10765.192610554397;10873.78252434931;10731.570737170427;10788.514516846604;10843.783124337311;10914.126869850552;10937.179711521827;8259.256666900008;8309.709160179365;8446.113158118555;8496.447730897471;8560.700375486827;8873.334499912404;8992.86510702353;9214.430426146451;9284.622560987564;9413.34106612558 21:29:57 INFO - PROCESS | 7091 | __end_tp_report 21:29:57 INFO - PROCESS | 7091 | __start_cc_report 21:29:57 INFO - PROCESS | 7091 | _x_x_mozilla_cycle_collect,752 21:29:57 INFO - PROCESS | 7091 | __end_cc_report 21:29:57 INFO - PROCESS | 7091 | __startTimestamp1453354197398__endTimestamp 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | ------- Summary: start ------- 21:29:57 INFO - PROCESS | 7091 | Number of tests: 6 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#0] dojo.html Cycles:165 Average:5198.17 Median:5382.65 stddev:552.02 (10.3%) stddev-sans-first:528.97 21:29:57 INFO - PROCESS | 7091 | Values: 3114.8 3159.0 3202.7 3210.6 3240.9 5143.0 5170.1 5237.4 5245.7 5258.6 5261.9 5280.9 5292.5 5305.8 5328.3 4697.5 4701.3 4721.8 4766.4 4830.3 4742.2 4782.7 4792.5 4848.9 4858.6 4695.3 4737.8 4786.5 4810.8 4813.6 4740.3 4778.1 4778.9 4780.5 4809.3 4654.5 4735.2 4751.2 4783.6 4823.1 5015.0 5043.5 5086.8 5108.1 5139.2 5571.7 5579.9 5581.5 5586.7 5625.0 5522.1 5625.0 5654.4 5656.9 5664.8 5248.6 5288.5 5304.4 5304.5 5353.1 5683.8 5684.5 5685.3 5688.7 5692.6 5448.5 5516.2 5524.2 5530.3 5531.5 5587.7 5624.3 5628.1 5632.9 5657.5 5553.2 5579.8 5592.7 5599.7 5599.8 5510.9 5559.8 5575.2 5580.4 5588.0 4401.2 4401.9 4409.4 4432.1 4446.1 3899.7 3924.2 3926.0 3958.1 3972.6 5111.9 5162.2 5199.2 5228.6 5268.7 5512.4 5548.8 5554.5 5581.9 5589.8 5140.6 5155.5 5161.1 5170.8 5181.7 4713.4 4789.6 4808.5 4829.9 4892.1 5727.9 5730.9 5731.3 5736.7 5745.6 5453.7 5574.7 5582.4 5584.0 5626.2 5653.6 5705.1 5747.9 5753.9 5779.2 5571.9 5577.2 5584.2 5588.0 5593.1 5607.9 5612.7 5659.3 5683.6 5686.3 5326.7 5419.2 5431.4 5463.5 5520.6 5462.3 5478.2 5483.1 5485.6 5487.8 5275.5 5367.0 5382.7 5383.3 5436.2 5445.3 5463.3 5467.3 5487.3 5532.1 5335.7 5337.5 5339.8 5345.2 5384.3 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#1] ext.html Cycles:180 Average:43400.19 Median:35388.32 stddev:73563.18 (207.9%) stddev-sans-first:73699.07 21:29:57 INFO - PROCESS | 7091 | Values: 513.8 516.7 546.0 546.6 568.7 29197.9 35280.6 35496.0 35547.3 35591.1 38037.8 38480.8 38496.8 38530.0 38594.4 8457.4 8741.2 8749.5 8760.4 8762.6 8454.2 8554.2 8581.3 8588.5 8597.1 8561.0 8602.5 8608.9 8642.1 8661.5 8529.4 8612.8 8617.9 8620.6 8625.3 8102.6 8179.6 8181.1 8195.3 8491.9 37359.8 37751.4 37773.8 37831.8 37910.4 3222.2 3269.8 3338.2 3340.0 3424.7 28642.9 28644.6 28875.1 29035.6 29910.0 3755.9 3781.8 3894.9 3923.4 4000.8 249529.0 249622.0 249727.0 274241.0 276981.0 53601.0 54403.7 54773.7 54774.6 54807.0 50468.0 50683.2 50728.0 50848.2 50869.7 12213.1 12409.3 12463.0 12611.7 12817.2 8968.5 8980.6 8998.1 9126.1 9215.1 17372.5 17491.1 17502.0 17610.1 17666.9 7363.4 7500.2 7516.5 7531.8 7554.1 892.2 985.6 1044.3 1048.1 1063.2 27328.6 27333.3 27489.5 27644.3 27689.7 966.1 978.8 981.3 1108.7 1121.1 14190.7 14601.3 14607.8 15127.7 15261.5 252320.0 255474.0 256087.0 256234.0 256848.5 45484.3 45519.3 45707.8 45742.0 45765.0 1310.7 1323.7 1337.2 1344.5 1346.2 25536.6 28164.0 28487.6 28668.4 28789.3 43581.1 43802.8 43841.3 44001.0 44071.1 290296.0 294939.0 298627.0 303149.0 409772.0 30320.7 30338.2 30393.0 30608.5 30818.8 38970.0 39815.8 39824.4 40291.0 40351.6 33469.3 33612.7 34225.7 34314.1 34337.8 34364.0 34812.8 35006.3 35083.0 35252.0 31338.2 31368.7 31499.8 31536.5 33749.7 27534.0 28029.3 29178.3 29339.3 29503.9 22253.7 22904.2 23027.2 23096.2 24352.4 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#2] jquery.html Cycles:180 Average:25636.36 Median:22612.18 stddev:78098.95 (345.4%) stddev-sans-first:78294.98 21:29:57 INFO - PROCESS | 7091 | Values: 362.1 364.3 366.7 366.9 371.6 13670.2 13742.2 15979.9 16521.1 17337.0 15374.9 15820.8 16118.0 16716.8 16726.5 4818.4 4974.7 5018.3 5033.1 5035.7 3795.4 3908.4 5046.8 5105.9 6553.3 6520.2 6700.5 6783.3 6783.9 6784.5 6580.7 6604.2 6605.5 6630.1 6665.9 6190.3 6552.2 6553.5 6555.3 6557.1 21407.8 21813.2 22677.3 22790.4 22794.5 2131.3 2138.4 2149.0 2228.3 2279.6 13350.9 13360.7 13772.8 14047.4 14268.3 1822.4 1848.7 1863.5 1904.5 1974.8 58340.7 59862.0 61477.0 61563.0 61881.0 14669.3 14713.2 14823.9 14911.3 15110.4 23074.1 23148.7 23334.4 23383.7 23390.8 8099.3 8117.6 8169.1 8176.9 8206.8 6668.0 6670.3 6687.3 6745.0 6751.8 6660.9 7419.3 7447.4 7460.9 7581.0 2615.6 2974.2 2984.7 3001.2 3057.5 417.3 420.3 426.6 434.7 832.9 10721.5 11072.9 11197.2 11378.1 11569.5 452.4 454.0 454.3 460.5 482.7 6094.6 6151.9 6300.7 6308.3 9336.0 383789.0 392743.0 456087.0 529644.0 597184.0 44772.0 45274.1 46249.0 48880.8 74054.0 1022.5 1104.7 1126.0 1126.8 1136.3 11931.4 14339.4 14492.3 14637.5 14789.9 30521.0 31268.4 31659.7 31786.5 33838.0 41459.0 42578.8 44221.8 44389.8 44510.6 7419.9 7631.8 7666.2 7687.0 7817.9 10130.5 10729.9 11566.9 11599.4 11844.3 8703.3 9170.6 9549.4 9808.3 9905.3 9446.5 9507.3 9622.1 9987.5 10259.2 9260.0 9733.9 9772.4 9799.9 10392.7 7131.1 7204.2 7207.6 7547.2 7669.0 8780.9 9038.9 9063.4 9082.8 9225.6 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#3] mootools.html Cycles:180 Average:5499.68 Median:6399.89 stddev:2835.94 (44.3%) stddev-sans-first:2826.29 21:29:57 INFO - PROCESS | 7091 | Values: 1296.1 1465.3 1491.7 1651.8 1787.4 6975.1 7503.4 7649.0 7650.1 7701.8 7466.6 7538.8 7590.2 7592.4 7630.2 1984.8 2024.8 2267.1 2272.7 2298.1 2346.2 2355.9 2356.5 2357.8 2357.8 2240.2 2302.6 2303.2 2303.8 2304.1 2268.6 2296.7 2336.5 2347.9 2356.4 2301.7 2307.1 2307.6 2322.4 2348.6 7894.0 7899.5 7912.8 7922.8 7982.4 4791.6 4824.4 4876.7 4889.5 4894.8 3104.0 3153.4 3195.0 3199.7 3211.7 978.8 983.4 1012.8 1023.6 1024.7 11012.1 11014.3 11025.1 11026.7 11030.5 4375.9 4443.6 4445.5 4482.3 4492.7 9392.0 9405.2 9414.4 9422.0 9438.3 4892.9 4904.2 4940.6 4943.8 4949.8 4437.1 4461.7 4474.5 4474.5 4481.5 3449.4 3504.6 3718.5 3745.6 3773.6 1180.2 1182.1 1183.4 1192.9 1205.2 1287.2 1296.1 1313.4 1330.9 1332.8 7191.1 7230.1 7284.0 7289.1 7304.5 1072.1 1091.1 1096.8 1096.9 1098.3 5741.2 5824.4 5827.5 5832.2 5841.4 9133.4 9335.3 9471.1 9484.7 9632.1 9407.1 9416.5 9502.3 9504.7 9524.9 7239.9 7271.5 7307.8 7347.9 7357.7 6913.4 6939.8 6998.7 7004.6 7037.7 8022.3 8415.2 8454.4 8477.4 8609.1 8773.0 8819.6 8823.9 8828.4 8828.5 6180.6 6379.7 6500.8 6539.8 6549.3 6819.3 6879.0 7334.6 7468.4 7527.5 6884.9 6967.9 7037.2 7276.1 7343.1 6918.2 6949.3 7059.0 7078.6 7210.2 7158.6 7200.6 7248.6 7249.7 7263.2 6313.4 6420.1 6427.4 6447.3 6466.2 6590.5 6595.7 6600.4 6619.4 6622.9 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#4] prototype.html Cycles:180 Average:5215.98 Median:5892.54 stddev:1567.78 (26.6%) stddev-sans-first:1528.60 21:29:57 INFO - PROCESS | 7091 | Values: 325.4 331.9 342.6 344.1 349.6 5744.2 5874.5 5890.9 5909.6 5911.1 5644.9 5807.7 5818.6 5854.6 5858.0 4552.7 4553.7 4557.9 4566.8 4569.8 4344.5 4428.1 4447.6 4474.1 4551.9 4419.0 4498.1 4504.3 4508.1 4538.9 4515.6 4518.3 4525.6 4526.7 4530.4 4004.5 4005.9 4012.4 4019.0 4020.3 5463.8 5603.6 5626.1 5658.3 5660.8 5176.2 5203.3 5207.4 5208.7 5212.4 5893.4 6220.5 6222.3 6235.4 6248.8 4222.9 4224.8 4306.9 4326.9 4332.3 6361.7 6430.3 6438.8 6444.4 6459.1 4380.4 4402.2 4403.4 4403.8 4408.1 4331.7 4456.8 4464.6 4466.3 4466.4 5162.6 5168.2 5168.9 5175.3 5176.5 6250.9 6259.1 6267.5 6275.8 6277.6 1563.0 1567.1 1569.1 1570.3 1570.7 1069.3 1074.1 1074.4 1092.6 1103.5 5912.9 5921.5 5926.9 5928.6 5932.4 6449.3 6451.8 6454.9 6460.4 6474.0 5862.2 5889.8 5891.7 5899.7 5919.4 3384.6 3496.5 3505.6 3505.7 3510.2 6705.4 6708.9 6716.9 6717.2 6761.4 6619.3 6622.8 6628.4 6631.3 6631.9 6498.9 6667.9 6673.0 6679.2 6680.2 6188.9 6368.4 6461.4 6465.4 6473.6 6232.0 6390.9 6397.8 6402.6 6421.9 6679.8 6683.3 6683.7 6685.7 6695.6 4316.2 4452.8 4487.3 4490.2 4491.9 6441.9 6456.3 6465.1 6466.7 6468.9 6228.7 6230.2 6232.9 6284.0 6291.9 6172.5 6206.3 6218.4 6275.1 6280.8 6081.8 6137.5 6149.1 6152.5 6153.3 6277.3 6288.6 6292.6 6301.5 6304.9 6022.8 6143.8 6145.0 6146.2 6157.5 21:29:57 INFO - PROCESS | 7091 | 21:29:57 INFO - PROCESS | 7091 | [#5] yui.html Cycles:180 Average:13725.15 Median:46161.72 stddev:15938.11 (34.5%) stddev-sans-first:15953.39 21:29:57 INFO - PROCESS | 7091 | Values: 826.7 853.6 853.7 853.7 861.2 13178.9 13319.7 13338.0 13354.7 13419.2 13822.7 14258.9 14280.9 14294.5 14302.2 776.5 788.0 788.4 788.4 789.6 652.3 661.7 771.0 797.3 798.6 836.2 844.0 846.7 847.0 847.3 680.4 690.1 842.2 843.6 843.8 599.5 615.7 616.8 616.9 616.9 13604.4 13705.6 13711.5 13720.1 13773.6 12226.6 12726.8 12795.2 12973.4 13062.3 10223.5 10246.4 10331.2 10380.2 10409.5 3593.5 3630.7 3672.5 3678.5 3741.5 47995.0 48097.3 48161.5 48470.0 48974.5 9788.2 9945.3 10036.7 10222.7 10298.6 18375.1 18383.0 18397.0 18407.5 18446.0 7410.3 7483.9 7538.5 7558.1 7643.7 4321.7 4335.8 4362.1 4375.7 4433.8 3048.7 3124.9 3129.0 3134.4 3137.9 593.0 599.9 602.4 612.3 613.8 555.4 641.6 670.7 675.5 687.1 8343.4 8611.4 8627.1 8778.8 9462.7 570.0 576.6 582.5 627.9 673.8 3677.5 3958.0 4166.1 4222.2 4241.2 53990.7 58347.7 58400.4 58579.7 58716.1 49744.8 50080.0 50799.5 50807.0 50880.0 44436.1 44557.8 45223.1 46676.6 46801.8 8136.8 8502.0 8502.6 8518.4 8574.0 35026.6 35506.0 35852.0 36060.3 36382.1 42403.8 45372.1 45390.5 45628.3 45646.8 10695.5 10784.6 10846.2 10916.7 11104.8 11375.9 11602.5 11605.9 11616.1 11628.7 10764.4 10773.9 10851.8 10888.2 10889.4 10428.5 10571.5 10699.9 10765.2 10873.8 10731.6 10788.5 10843.8 10914.1 10937.2 8259.3 8309.7 8446.1 8496.4 8560.7 8873.3 8992.9 9214.4 9284.6 9413.3 21:29:57 INFO - PROCESS | 7091 | -------- Summary: end -------- 21:29:57 INFO - PROCESS | 7091 | 21:29:58 INFO - TEST-INFO | 7091: exit 0 21:29:58 INFO - TEST-OK | dromaeo_css | took 1112733ms 21:29:58 INFO - TEST-START | kraken 21:29:58 INFO - operating with platform_type : linux_ 21:29:58 INFO - Initialising browser for kraken test... 21:29:58 INFO - TEST-INFO | started process 7293 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ5iWo1/profile http://localhost:33173/getInfo.html) 21:30:01 INFO - PROCESS | 7293 | __metrics Screen width/height:1600/1200 21:30:01 INFO - PROCESS | 7293 | colorDepth:24 21:30:01 INFO - PROCESS | 7293 | Browser inner width/height: 1024/697 21:30:01 INFO - PROCESS | 7293 | __metrics 21:30:01 INFO - PROCESS | 7293 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:30:01 INFO - PROCESS | 7293 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:30:03 INFO - TEST-INFO | 7293: exit 0 21:30:03 INFO - Browser initialized. 21:30:03 INFO - Running cycle 1/1 for kraken test... 21:30:03 INFO - TEST-INFO | started process 7374 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ5iWo1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:14 INFO - PROCESS | 7374 | RSS: Main: 149012480 21:30:14 INFO - PROCESS | 7374 | 21:30:17 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33173/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:17 INFO - PROCESS | 7374 | RSS: Main: 186544128 21:30:17 INFO - PROCESS | 7374 | 21:30:20 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33173/tests/kraken/driver.html?testName=audio-dft) 21:30:21 INFO - PROCESS | 7374 | RSS: Main: 177696768 21:30:21 INFO - PROCESS | 7374 | 21:30:23 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33173/tests/kraken/driver.html?testName=audio-fft) 21:30:24 INFO - PROCESS | 7374 | RSS: Main: 160825344 21:30:24 INFO - PROCESS | 7374 | 21:30:26 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33173/tests/kraken/driver.html?testName=audio-oscillator) 21:30:27 INFO - PROCESS | 7374 | RSS: Main: 164659200 21:30:27 INFO - PROCESS | 7374 | 21:30:29 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:30:29 INFO - PROCESS | 7374 | RSS: Main: 166141952 21:30:29 INFO - PROCESS | 7374 | 21:30:32 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33173/tests/kraken/driver.html?testName=imaging-darkroom) 21:30:33 INFO - PROCESS | 7374 | RSS: Main: 164306944 21:30:33 INFO - PROCESS | 7374 | 21:30:36 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33173/tests/kraken/driver.html?testName=imaging-desaturate) 21:30:37 INFO - PROCESS | 7374 | RSS: Main: 167645184 21:30:37 INFO - PROCESS | 7374 | 21:30:40 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33173/tests/kraken/driver.html?testName=json-parse-financial) 21:30:40 INFO - PROCESS | 7374 | RSS: Main: 165900288 21:30:40 INFO - PROCESS | 7374 | 21:30:42 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:30:42 INFO - PROCESS | 7374 | RSS: Main: 180228096 21:30:42 INFO - PROCESS | 7374 | 21:30:44 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:30:45 INFO - PROCESS | 7374 | RSS: Main: 175394816 21:30:45 INFO - PROCESS | 7374 | 21:30:47 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:30:47 INFO - PROCESS | 7374 | RSS: Main: 184848384 21:30:47 INFO - PROCESS | 7374 | 21:30:50 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:30:50 INFO - PROCESS | 7374 | RSS: Main: 192135168 21:30:50 INFO - PROCESS | 7374 | 21:30:53 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:30:53 INFO - PROCESS | 7374 | RSS: Main: 190386176 21:30:53 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:33173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33173/tests/kraken/driver.html?testName=ai-astar) 21:30:55 INFO - PROCESS | 7374 | RSS: Main: 250109952 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | __start_tp_report 21:30:55 INFO - PROCESS | 7374 | _x_x_mozilla_page_load 21:30:55 INFO - PROCESS | 7374 | _x_x_mozilla_page_load_details 21:30:55 INFO - PROCESS | 7374 | |i|pagename|runs| 21:30:55 INFO - PROCESS | 7374 | |0;ai-astar;110;109;105;110;108;110;110;112;105;111 21:30:55 INFO - PROCESS | 7374 | |1;audio-beat-detection;150;127;153;169;125;147;154;131;164;127 21:30:55 INFO - PROCESS | 7374 | |2;audio-dft;161;161;161;160;162;160;161;162;160;162 21:30:55 INFO - PROCESS | 7374 | |3;audio-fft;73;74;118;96;73;73;74;106;94;73 21:30:55 INFO - PROCESS | 7374 | |4;audio-oscillator;96;95;135;96;96;97;141;96;97;139 21:30:55 INFO - PROCESS | 7374 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;110;110;110 21:30:55 INFO - PROCESS | 7374 | |6;imaging-darkroom;146;146;147;146;146;146;146;145;146;146 21:30:55 INFO - PROCESS | 7374 | |7;imaging-desaturate;96;96;97;97;97;96;97;96;96;97 21:30:55 INFO - PROCESS | 7374 | |8;json-parse-financial;60;57;56;55;55;56;55;56;55;54 21:30:55 INFO - PROCESS | 7374 | |9;json-stringify-tinderbox;67;67;67;68;69;69;67;67;67;67 21:30:55 INFO - PROCESS | 7374 | |10;stanford-crypto-aes;81;88;83;83;90;87;81;83;83;84 21:30:55 INFO - PROCESS | 7374 | |11;stanford-crypto-ccm;117;120;117;125;126;123;125;119;123;118 21:30:55 INFO - PROCESS | 7374 | |12;stanford-crypto-pbkdf2;146;132;147;142;143;130;145;154;149;134 21:30:55 INFO - PROCESS | 7374 | |13;stanford-crypto-sha256-iterative;71;67;68;66;69;79;66;66;65;68 21:30:55 INFO - PROCESS | 7374 | __end_tp_report 21:30:55 INFO - PROCESS | 7374 | __start_cc_report 21:30:55 INFO - PROCESS | 7374 | _x_x_mozilla_cycle_collect,926 21:30:55 INFO - PROCESS | 7374 | __end_cc_report 21:30:55 INFO - PROCESS | 7374 | __startTimestamp1453354255774__endTimestamp 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | ------- Summary: start ------- 21:30:55 INFO - PROCESS | 7374 | Number of tests: 14 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.36 (2.1%) stddev-sans-first:2.47 21:30:55 INFO - PROCESS | 7374 | Values: 110.0 109.0 105.0 110.0 108.0 110.0 110.0 112.0 105.0 111.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:16.17 (10.7%) stddev-sans-first:17.04 21:30:55 INFO - PROCESS | 7374 | Values: 150.0 127.0 153.0 169.0 125.0 147.0 154.0 131.0 164.0 127.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 21:30:55 INFO - PROCESS | 7374 | Values: 161.0 161.0 161.0 160.0 162.0 160.0 161.0 162.0 160.0 162.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.50 stddev:16.83 (22.9%) stddev-sans-first:17.24 21:30:55 INFO - PROCESS | 7374 | Values: 73.0 74.0 118.0 96.0 73.0 73.0 74.0 106.0 94.0 73.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:96.00 stddev:20.44 (21.3%) stddev-sans-first:21.15 21:30:55 INFO - PROCESS | 7374 | Values: 96.0 95.0 135.0 96.0 96.0 97.0 141.0 96.0 97.0 139.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:30:55 INFO - PROCESS | 7374 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 21:30:55 INFO - PROCESS | 7374 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:30:55 INFO - PROCESS | 7374 | Values: 96.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 96.0 97.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:0.88 21:30:55 INFO - PROCESS | 7374 | Values: 60.0 57.0 56.0 55.0 55.0 56.0 55.0 56.0 55.0 54.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 21:30:55 INFO - PROCESS | 7374 | Values: 67.0 67.0 67.0 68.0 69.0 69.0 67.0 67.0 67.0 67.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.02 (3.6%) stddev-sans-first:2.96 21:30:55 INFO - PROCESS | 7374 | Values: 81.0 88.0 83.0 83.0 90.0 87.0 81.0 83.0 83.0 84.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:123.00 stddev:3.50 (2.8%) stddev-sans-first:3.35 21:30:55 INFO - PROCESS | 7374 | Values: 117.0 120.0 117.0 125.0 126.0 123.0 125.0 119.0 123.0 118.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:145.50 stddev:7.83 (5.4%) stddev-sans-first:8.18 21:30:55 INFO - PROCESS | 7374 | Values: 146.0 132.0 147.0 142.0 143.0 130.0 145.0 154.0 149.0 134.0 21:30:55 INFO - PROCESS | 7374 | 21:30:55 INFO - PROCESS | 7374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:4.09 (6.0%) stddev-sans-first:4.24 21:30:55 INFO - PROCESS | 7374 | Values: 71.0 67.0 68.0 66.0 69.0 79.0 66.0 66.0 65.0 68.0 21:30:55 INFO - PROCESS | 7374 | -------- Summary: end -------- 21:30:55 INFO - PROCESS | 7374 | 21:30:56 INFO - TEST-INFO | 7374: exit 0 21:30:56 INFO - TEST-OK | kraken | took 58569ms 21:30:56 INFO - TEST-START | v8_7 21:30:56 INFO - operating with platform_type : linux_ 21:30:56 INFO - Initialising browser for v8_7 test... 21:30:56 INFO - TEST-INFO | started process 7626 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKcbQTg/profile http://localhost:33173/getInfo.html) 21:31:00 INFO - PROCESS | 7626 | __metrics Screen width/height:1600/1200 21:31:00 INFO - PROCESS | 7626 | colorDepth:24 21:31:00 INFO - PROCESS | 7626 | Browser inner width/height: 1024/697 21:31:00 INFO - PROCESS | 7626 | __metrics 21:31:00 INFO - PROCESS | 7626 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:31:00 INFO - PROCESS | 7626 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:31:01 INFO - TEST-INFO | 7626: exit 0 21:31:01 INFO - Browser initialized. 21:31:01 INFO - Running cycle 1/1 for v8_7 test... 21:31:01 INFO - TEST-INFO | started process 7708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKcbQTg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:13 INFO - PROCESS | 7708 | RSS: Main: 149118976 21:31:13 INFO - PROCESS | 7708 | 21:31:35 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:33173/tests/v8_7/run.html (next: http://localhost:33173/tests/v8_7/run.html) 21:31:36 INFO - PROCESS | 7708 | RSS: Main: 553824256 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | __start_tp_report 21:31:36 INFO - PROCESS | 7708 | _x_x_mozilla_page_load 21:31:36 INFO - PROCESS | 7708 | _x_x_mozilla_page_load_details 21:31:36 INFO - PROCESS | 7708 | |i|pagename|runs| 21:31:36 INFO - PROCESS | 7708 | |0;Richards;166.58337497917708 21:31:36 INFO - PROCESS | 7708 | |1;DeltaBlue;188.25301204819277 21:31:36 INFO - PROCESS | 7708 | |2;Encrypt;280.97780275358247 21:31:36 INFO - PROCESS | 7708 | |3;Decrypt;5181.347150259067 21:31:36 INFO - PROCESS | 7708 | |4;RayTrace;1990.0596421471173 21:31:36 INFO - PROCESS | 7708 | |5;Earley;776.3975155279503 21:31:36 INFO - PROCESS | 7708 | |6;Boyer;12456.79012345679 21:31:36 INFO - PROCESS | 7708 | |7;RegExp;41693.87755102041 21:31:36 INFO - PROCESS | 7708 | |8;Splay;568.1946802490096 21:31:36 INFO - PROCESS | 7708 | |9;NavierStokes;4835.748792270531 21:31:36 INFO - PROCESS | 7708 | __end_tp_report 21:31:36 INFO - PROCESS | 7708 | __startTimestamp1453354296239__endTimestamp 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | ------- Summary: start ------- 21:31:36 INFO - PROCESS | 7708 | Number of tests: 10 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#0] Richards Cycles:1 Average:166.58 Median:166.58 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 166.6 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 188.3 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 281.0 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 5181.3 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 1990.1 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#5] Earley Cycles:1 Average:776.40 Median:776.40 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 776.4 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#6] Boyer Cycles:1 Average:12456.79 Median:12456.79 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 12456.8 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#7] RegExp Cycles:1 Average:41693.88 Median:41693.88 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 41693.9 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#8] Splay Cycles:1 Average:568.19 Median:568.19 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 568.2 21:31:36 INFO - PROCESS | 7708 | 21:31:36 INFO - PROCESS | 7708 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 21:31:36 INFO - PROCESS | 7708 | Values: 4835.7 21:31:36 INFO - PROCESS | 7708 | -------- Summary: end -------- 21:31:36 INFO - PROCESS | 7708 | 21:31:37 INFO - TEST-INFO | 7708: exit 0 21:31:37 INFO - TEST-OK | v8_7 | took 40459ms 21:31:37 INFO - SUITE-END | took 1211s 21:31:37 INFO - Completed test suite (00:20:11) 21:31:37 INFO - Working with test: dromaeo_css 21:31:37 INFO - Generating results file: dromaeo_css 21:31:37 INFO - Working with test: kraken 21:31:37 INFO - Generating results file: kraken 21:31:37 INFO - javascript benchmark 21:31:37 INFO - Working with test: v8_7 21:31:37 INFO - Generating results file: v8_7 21:31:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 21:31:37 INFO - process_Request line: dromaeo_css 6791.94 graph.html#tests=[[72,64,35]] 21:31:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:37 INFO - process_Request line: kraken 1500.50 graph.html#tests=[[232,64,35]] 21:31:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:37 INFO - process_Request line: v8_7 19043.08 graph.html#tests=[[230,64,35]] 21:31:37 INFO - RETURN: dromaeo_css: 6791.94 21:31:37 INFO - RETURN: kraken: 1500.50 21:31:37 INFO - RETURN: v8_7: 19043.08 21:31:37 INFO - javascript benchmark 21:31:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.8442577871106, 3159.0, 3202.7437804975602, 3210.5826242588473, 3240.85416156273, 5143.0, 5170.14692575725, 5237.3715154181555, 5245.659032162912, 5258.579313654908, 5261.8947621047655, 5280.867978300545, 5292.497212764782, 5305.814296499613, 5328.254044433773, 4697.53024697531, 4701.271302948048, 4721.787519561611, 4766.380370551823, 4830.323754674331, 4742.241241401376, 4782.713037217778, 4792.496787837279, 4848.854534363974, 4858.611311095122, 4695.3426520287185, 4737.810487580493, 4786.545278198548, 4810.759462026919, 4813.638977076698, 4740.312654665088, 4778.092162489151, 4778.880527986794, 4780.4741478437345, 4809.302651115604, 4654.4647365553055, 4735.195016847144, 4751.1922973094315, 4783.641226907961, 4823.059503396804, 5014.974925125351, 5043.5460808527405, 5086.821961231339, 5108.106081435734, 5139.203423469331, 5571.721413929287, 5579.888402231933, 5581.525570326487, 5586.692731899744, 5625.043742563774, 5522.088855338864, 5625.043742563774, 5654.37801841797, 5656.91514627281, 5664.801731939404, 5248.580113590903, 5288.471152884719, 5304.416514183436, 5304.496072873109, 5353.063213937546, 5683.8010669626365, 5684.54523638108, 5685.260916080883, 5688.744006519716, 5692.601517893708, 5448.509634132947, 5516.172574113915, 5524.226608274845, 5530.336359636869, 5531.502164805187, 5587.664740115525, 5624.3250809903075, 5628.071368224197, 5632.915506267409, 5657.547396208293, 5553.194786755897, 5579.776808927679, 5592.720363981784, 5599.692016939108, 5599.824036952205, 5510.889782204334, 5559.833205003856, 5575.191597218381, 5580.414056524007, 5587.99416105105, 4401.163778882003, 4401.911961760747, 4409.4267745193565, 4432.135733531994, 4446.133004064176, 3899.707521935866, 3924.2151569686175, 3925.9803700981884, 3958.050067983663, 3972.5828787977425, 5111.923321150186, 5162.174052151638, 5199.168133098686, 5228.6339956203465, 5268.6575372600655, 5512.4211957744665, 5548.778048878, 5554.50009499147, 5581.916271255935, 5589.776408943597, 5140.614453915971, 5155.510226528474, 5161.122609156452, 5170.767315470737, 5181.663191892515, 4713.363695901078, 4789.568938795525, 4808.543188397167, 4829.9034019319415, 4892.143874821963, 5727.8568035799435, 5730.885382292331, 5731.312242530923, 5736.6558006519745, 5745.569082318842, 5453.672779633234, 5574.693391863487, 5582.385937546947, 5584.0, 5626.24045753818, 5653.604247702621, 5705.058665320342, 5747.9137812932, 5753.9136912945505, 5779.248697669276, 5571.8885622288135, 5577.247071645276, 5584.218209450599, 5588.022096133079, 5593.133064375028, 5607.943920560742, 5612.663240205601, 5659.26429564154, 5683.573731970201, 5686.2607860977805, 5326.707031113326, 5419.160030195326, 5431.402545720047, 5463.453654634504, 5520.558355331484, 5462.289902312833, 5478.150886612581, 5483.095289277384, 5485.588580856372, 5487.780488780564, 5275.472452754694, 5367.0, 5382.650127741685, 5383.26972010185, 5436.157395603688, 5445.292112025411, 5463.262459568066, 5467.316585426822, 5487.341519017744, 5532.1425179097305, 5335.733213339395, 5337.466253374631, 5339.7597108131, 5345.1714984177515, 5384.326959130109], "unit": "score", "name": "dojo.html", "value": 5164.0332593673265}, {"lowerIsBetter": false, "replicates": [513.7765072193596, 516.6977318268813, 546.0144439287086, 546.5682111132206, 568.6616463204393, 29197.85401072994, 35280.64719352806, 35495.99999999997, 35547.2890542189, 35591.11022224445, 38037.809810950974, 38480.807595962055, 38496.80751596245, 38530.036749081286, 38594.421083683694, 8457.407981441285, 8741.169588889044, 8749.4750314981, 8760.4305720128, 8762.649494020232, 8454.196851299148, 8554.230119289263, 8581.270591999688, 8588.527630980294, 8597.140285971383, 8560.957195214047, 8602.48385096893, 8608.870866937, 8642.092580279075, 8661.523616201106, 8529.360297977646, 8612.827743445096, 8617.870731939025, 8620.568971551429, 8625.309975201968, 8102.5543595102245, 8179.631916563769, 8181.059178194524, 8195.34437245019, 8491.872621910676, 37359.81320093382, 37751.43372849409, 37773.81113094444, 37831.81084094562, 37910.43134352987, 3222.226665600239, 3269.8038117713013, 3338.21551935295, 3340.048086295394, 3424.6917777399904, 28642.856785716147, 28644.570331445044, 28875.133745987652, 29035.56446653302, 29910.0, 3755.8732280558233, 3781.829817658212, 3894.941575876364, 3923.4114882767526, 4000.7799571023584, 249529.0, 249622.0, 249727.0, 274241.0, 276981.0, 53601.0, 54403.72798136063, 54773.72613136909, 54774.605428267474, 54807.0, 50468.0, 50683.23975140376, 50728.0, 50848.23727644089, 50869.676077533826, 12213.145079844326, 12409.255444673348, 12463.0, 12611.684707882192, 12817.23096614206, 8968.506732129665, 8980.640774368952, 8998.10018998108, 9126.087391260953, 9215.078492150866, 17372.47882563525, 17491.125443727764, 17502.0, 17610.119494025246, 17666.911665441592, 7363.410927125817, 7500.249975002456, 7516.534275816272, 7531.849363012709, 7554.093508778982, 892.2014796756866, 985.5959056786683, 1044.300318786415, 1048.0567489259574, 1063.2025980514613, 27328.59007114895, 27333.316667083483, 27489.450210995667, 27644.308892277855, 27689.723102768716, 966.12083004467, 978.848278516831, 981.288565789811, 1108.6958679490717, 1121.114319687454, 14190.749422713456, 14601.269936503133, 14607.78088328676, 15127.697446051017, 15261.465848695243, 252320.0, 255474.0, 256087.0, 256234.0, 256848.45212382966, 45484.317735234, 45519.317210241876, 45707.771461143144, 45742.0, 45765.0, 1310.6657802260363, 1323.6690827293178, 1337.224409842289, 1344.5294147048455, 1346.199011588123, 25536.616950746124, 28164.0, 28487.572686409305, 28668.42663146767, 28789.28026799347, 43581.128377432906, 43802.78098609487, 43841.34237986497, 44001.0, 44071.118577627625, 290296.0, 294939.0, 298627.0, 303149.0, 409772.0, 30320.69679303267, 30338.241543961576, 30393.0, 30608.540871887384, 30818.84590577033, 38970.0, 39815.80092099637, 39824.40263395994, 40291.0, 40351.59648403478, 33469.33061338808, 33612.66387336193, 34225.65774342225, 34314.14214644654, 34337.828310858284, 34364.0, 34812.82593587016, 35006.29987400187, 35083.0, 35252.0, 31338.21654458657, 31368.686313136575, 31499.84250078735, 31536.526952096196, 33749.662503375635, 27534.0, 28029.299267518476, 29178.270543236587, 29339.266518336357, 29503.85248073746, 22253.666195007412, 22904.198353057564, 23027.194048208232, 23096.191633292754, 24352.391190219678], "unit": "score", "name": "ext.html", "value": 17310.170486064366}, {"lowerIsBetter": false, "replicates": [362.09115121046165, 364.3369068295702, 366.7249562827879, 366.8514251728051, 371.58568196460953, 13670.179789212629, 13742.244176570284, 15979.920100399497, 16521.091339976298, 17337.0, 15374.923125384385, 15820.841791582081, 16118.0, 16716.83283167168, 16726.498205053867, 4818.3736114305175, 4974.676646018015, 5018.34761481007, 5033.11920413928, 5035.672681275723, 3795.430685397185, 3908.413737939318, 5046.848594542152, 5105.948940510603, 6553.311902250267, 6520.152380190569, 6700.463962882982, 6783.253842077367, 6783.898241526381, 6784.525083244175, 6580.703868325937, 6604.24051234107, 6605.504587155934, 6630.138082049351, 6665.93334066658, 6190.2571691397325, 6552.246491653474, 6553.475721942281, 6555.278919318871, 6557.114789503404, 21407.785922140734, 21813.23653672114, 22677.319680409615, 22790.430239244153, 22794.544109117724, 2131.2753663754243, 2138.379869837745, 2149.0, 2228.3092241405216, 2279.578278018572, 13350.93192544594, 13360.732785344337, 13772.793408098887, 14047.367868445945, 14268.286585670676, 1822.4168266154836, 1848.667239896818, 1863.4782260966952, 1904.5333893196255, 1974.7827738948704, 58340.708296458244, 59862.0, 61477.0, 61563.0, 61881.0, 14669.33987970544, 14713.164673229438, 14823.851761482463, 14911.328990195467, 15110.39558417673, 23074.077036918672, 23148.65277020846, 23334.416639584146, 23383.661633836822, 23390.766092338858, 8099.271065604124, 8117.594120293962, 8169.060558035783, 8176.877346839802, 8206.794830129294, 6668.0, 6670.266270710218, 6687.331266873371, 6745.0, 6751.831204219836, 6660.8667826643195, 7419.332260096618, 7447.3669738071785, 7460.888086678704, 7580.9620951894885, 2615.594582839663, 2974.1523665755158, 2984.701529846998, 3001.2046807596003, 3057.4955132402906, 417.2572820379729, 420.2939062375239, 426.62670163606845, 434.6566212692001, 832.908889354947, 10721.463926803628, 11072.944635276772, 11197.216194866443, 11378.146639002109, 11569.479373428216, 452.3508764922347, 453.95687409696023, 454.27543068805204, 460.537160154043, 482.66937148053694, 6094.634321940698, 6151.876962460815, 6300.684965751694, 6308.3060863305, 9335.953320233355, 383789.0, 392743.0, 456087.0, 529644.0, 597184.0, 44772.0, 45274.09451810945, 46249.0, 48880.75559622179, 74054.0, 1022.5040855185377, 1104.6851647280487, 1125.954961801535, 1126.7915435644431, 1136.335243882338, 11931.403429828648, 14339.426422943383, 14492.275386230436, 14637.487687930872, 14789.855470956867, 30521.0, 31268.37463250768, 31659.683403165673, 31786.517415420964, 33838.0, 41459.0, 42578.78710606427, 44221.778891105336, 44389.77805110954, 44510.554894450644, 7419.888701669587, 7631.771046868603, 7666.233376662289, 7687.0, 7817.921820781947, 10130.493475326057, 10729.9463502682, 11566.94216528912, 11599.420028998686, 11844.348560829238, 8703.347248956226, 9170.649928650675, 9549.379290346105, 9808.313418060667, 9905.306628535933, 9446.480443575669, 9507.286953478379, 9622.113191349137, 9987.450690212108, 10259.179265658879, 9259.953700231456, 9733.853992189981, 9772.413655180711, 9799.902000979899, 10392.740181495523, 7131.108611423572, 7204.171520275236, 7207.5675459472595, 7547.245275472628, 7669.003029606339, 8780.912190878265, 9038.90961090407, 9063.41087829289, 9082.818343633222, 9225.630974760934], "unit": "score", "name": "jquery.html", "value": 8243.003076851288}, {"lowerIsBetter": false, "replicates": [1296.1121631682292, 1465.2966576043498, 1491.694202688449, 1651.7852679151715, 1787.436957358432, 6975.058367120438, 7503.362214211792, 7648.961755191216, 7650.0819901611885, 7701.845963080735, 7466.626668666572, 7538.773836784905, 7590.1650818409935, 7592.392608591299, 7630.198829122945, 1984.8213660770527, 2024.8076432738867, 2267.093162734911, 2272.71591051119, 2298.092253559843, 2346.2022912209845, 2355.9411014724596, 2356.4815740537056, 2357.834951553392, 2357.834951553392, 2240.249516411996, 2302.6085565453914, 2303.1823702585593, 2303.7696230376996, 2304.1474654377903, 2268.5803126421583, 2296.7473577906417, 2336.532693461306, 2347.8708671023087, 2356.4344557306295, 2301.6547517872286, 2307.065638416444, 2307.596170670126, 2322.3613506285737, 2348.6007378745653, 7894.0, 7899.486533375312, 7912.802179945547, 7922.80192995174, 7982.401319901031, 4791.6166706663735, 4824.372831531913, 4876.658633895629, 4889.511048895082, 4894.755262236909, 3103.968960310413, 3153.369326134782, 3195.0, 3199.664035276309, 3211.6948889855425, 978.7699890525721, 983.4001259231862, 1012.8025035118155, 1023.5803320638503, 1024.6977141743203, 11012.119030477543, 11014.284071535405, 11025.062869656089, 11026.724331891766, 11030.50362733679, 4375.912481750347, 4443.622292105143, 4445.466544014739, 4482.327650852399, 4492.685512014193, 9391.953040234892, 9405.247580193569, 9414.388064775767, 9421.952890235505, 9438.339316247797, 4892.8532144035735, 4904.239842824368, 4940.629452790983, 4943.826966056171, 4949.7772600233075, 4437.068215674744, 4461.709988850715, 4474.463064432289, 4474.485434175046, 4481.484629267676, 3449.379111759907, 3504.649535046526, 3718.535183102112, 3745.550533935945, 3773.6226377362045, 1180.15029178991, 1182.1134149387958, 1183.402381797187, 1192.9045676345872, 1205.1684337806885, 1287.1504806827636, 1296.0603562417361, 1313.4089659653193, 1330.9068365214537, 1332.7534406134896, 7191.137063552407, 7230.096237970254, 7283.963580182065, 7289.052423184952, 7304.452166087564, 1072.0887245840972, 1091.1489038549944, 1096.8464414981909, 1096.857408536885, 1098.3464838421128, 5741.167530708024, 5824.446677565625, 5827.475527202488, 5832.24180856486, 5841.386654401312, 9133.40632858862, 9335.346525743133, 9471.10024547667, 9484.715458536255, 9632.13310802017, 9407.106324899123, 9416.529173541432, 9502.287328450255, 9504.667336643184, 9524.8571271431, 7239.9276007240305, 7271.454640901953, 7307.794213954744, 7347.853042939111, 7357.742479013209, 6913.3777959983845, 6939.826504337432, 6998.740226759232, 7004.579725216503, 7037.683304251424, 8022.27799498048, 8415.158484151536, 8454.40819142654, 8477.406581539233, 8609.053004169662, 8773.034966153846, 8819.647214111365, 8823.911760882309, 8828.42615230008, 8828.514431706319, 6180.567360284737, 6379.6810159490915, 6500.772472963424, 6539.771108011197, 6549.279579246374, 6819.318068193141, 6879.036934829028, 7334.559926404433, 7468.402527797872, 7527.473076884785, 6884.8967265490055, 6967.860642787217, 7037.190723066913, 7276.05411296528, 7343.118825740731, 6918.204406493318, 6949.270326615632, 7058.964705176441, 7078.646067696492, 7210.206877243394, 7158.6420678964805, 7200.567965921852, 7248.601326926859, 7249.710011599477, 7263.237360077116, 6313.3686631336495, 6420.101185834081, 6427.389398007182, 6447.258565264867, 6466.224053113657, 6590.47276217911, 6595.736170553124, 6600.438962688226, 6619.371159739817, 6622.867542649216], "unit": "score", "name": "mootools.html", "value": 4533.234958156365}, {"lowerIsBetter": false, "replicates": [325.37040826001686, 331.88549950267156, 342.60600309643905, 344.14308372153346, 349.6486031538305, 5744.224529688491, 5874.530037596993, 5890.911636325448, 5909.645421274721, 5911.113333000052, 5644.915326270099, 5807.651540907548, 5818.563607729427, 5854.648721076738, 5858.0, 4552.681312308131, 4553.749543775091, 4557.886052848672, 4566.835456958471, 4569.794359253841, 4344.45694288214, 4428.070105277896, 4447.5552444755585, 4474.127545128685, 4551.931721024187, 4418.955810441903, 4498.122866041123, 4504.279315309551, 4508.143452743984, 4538.863834084983, 4515.61617262533, 4518.254488009475, 4525.592696657317, 4526.705764125321, 4530.433695788027, 4004.4794176757127, 4005.859794907193, 4012.4382586437923, 4019.035431496449, 4020.336644453691, 5463.836084917459, 5603.579731520153, 5626.12795016769, 5658.292713410824, 5660.801871934463, 5176.249443830661, 5203.349581302337, 5207.427183009866, 5208.661437006583, 5212.4266330703595, 5893.381194974551, 6220.47125994291, 6222.284437289724, 6235.438810507031, 6248.812535623893, 4222.915541689149, 4224.831006759757, 4306.935395969063, 4326.913461730779, 4332.306830907071, 6361.745530178788, 6430.324815894357, 6438.774642887476, 6444.355564443518, 6459.128017717595, 4380.386745855582, 4402.163588918095, 4403.4495688039, 4403.801828917706, 4408.052268762167, 4331.675124365685, 4456.777161141995, 4464.620507256855, 4466.330050492452, 4466.441694788152, 5162.6128040397125, 5168.2169651470185, 5168.870778230575, 5175.275461435402, 5176.50823171798, 6250.874982500324, 6259.123722678829, 6267.5299352548745, 6275.780347687901, 6277.5605707600025, 1563.0231105559026, 1567.0910871694389, 1569.1212920764408, 1570.348305453247, 1570.7486802111607, 1069.2835800014009, 1074.0870260278857, 1074.414444127952, 1092.5575142067476, 1103.5475455063386, 5912.9113063304085, 5921.496672782776, 5926.851828704231, 5928.644281343133, 5932.40675932412, 6449.290578036413, 6451.774187903495, 6454.903176452357, 6460.3862633049785, 6474.0, 5862.208601838783, 5889.793857215062, 5891.705414729332, 5899.7050147492455, 5919.437653422918, 3384.610769761509, 3496.493008513751, 3505.5618047744033, 3505.702015328726, 3510.24529726105, 6705.430038446787, 6708.865822683519, 6716.899246511306, 6717.16035495563, 6761.357671021246, 6619.3380661933425, 6622.8344291393105, 6628.436582890412, 6631.303713110054, 6631.933680663228, 6498.935010649833, 6667.899611622323, 6672.966635166793, 6679.198496180489, 6680.198376194888, 6188.907166392418, 6368.395002474757, 6461.386168314003, 6465.3857883501, 6473.579217350857, 6232.0, 6390.93609063922, 6397.808065758035, 6402.5518213726455, 6421.935780642134, 6679.799606011828, 6683.298253683488, 6683.665816709048, 6685.732570697118, 6695.598264104169, 4316.201502722007, 4452.799624016991, 4487.282034874535, 4490.236659767913, 4491.865244042684, 6441.935580644134, 6456.257530384066, 6465.127207827071, 6466.708998095191, 6468.902966455601, 6228.719707613078, 6230.190075290365, 6232.906506402498, 6283.96858015707, 6291.937080629135, 6172.530987604814, 6206.255249369924, 6218.378162183745, 6275.058741188858, 6280.8429789253805, 6081.817545473643, 6137.478314343331, 6149.108379285068, 6152.477039451518, 6153.292371377349, 6277.278113016879, 6288.622682639057, 6292.590981586182, 6301.527385446201, 6304.873902522016, 6022.789202378071, 6143.815685529441, 6144.969275153596, 6146.231721034871, 6157.476614487819], "unit": "score", "name": "prototype.html", "value": 4710.246282356087}, {"lowerIsBetter": false, "replicates": [826.698255136875, 853.5902766671993, 853.6670698427611, 853.6969375871565, 861.164670269838, 13178.868211317884, 13319.667008324797, 13338.0, 13354.7329053419, 13419.194848309096, 13822.654433639163, 14258.928705356484, 14280.928595357034, 14294.499692510764, 14302.213378264192, 776.4564804636763, 788.03072221168, 788.3850596534712, 788.4126325887194, 789.6130895861044, 652.3346186889394, 661.7452280871851, 771.0477560213133, 797.3461761355691, 798.5967086621278, 836.2348451167175, 844.0167205205928, 846.7417437681505, 847.0259201917783, 847.2755793796308, 680.43863812355, 690.1132045321788, 842.2167384332569, 843.641452382738, 843.7763992541982, 599.5353600959248, 615.7229246838896, 616.8272883592601, 616.8827922694719, 616.9228846394201, 13604.38780254881, 13705.588832334946, 13711.45154193831, 13720.108192967426, 13773.586792396243, 12226.572069977508, 12726.80909786354, 12795.232286062866, 12973.41619627119, 13062.346882655924, 10223.539940702687, 10246.436445995467, 10331.173506119492, 10380.221483388776, 10409.479526023668, 3593.4969104325414, 3630.6913912317486, 3672.485851980725, 3678.521792167028, 3741.4761933329355, 47995.0, 48097.27854082191, 48161.5183848164, 48470.0, 48974.51025489735, 9788.168005719594, 9945.303828732063, 10036.698899032895, 10222.693319200436, 10298.588056477807, 18375.08124593765, 18383.0, 18396.98816565075, 18407.53981150455, 18446.0, 7410.333070023724, 7483.8877416838795, 7538.472306938462, 7558.13081495624, 7643.656035478417, 4321.67587430944, 4335.82656693735, 4362.083962367875, 4375.715578487452, 4433.8226470941445, 3048.679888611708, 3124.89062882798, 3128.9843550782102, 3134.4044631519937, 3137.9215519611735, 593.0333556303198, 599.8620317327039, 602.3825578781783, 612.2897438970862, 613.7544982007233, 555.386298140557, 641.6310621392718, 670.6579644381303, 675.5440077947366, 687.1033301541437, 8343.41596088268, 8611.440256383315, 8627.137286271323, 8778.824423511494, 9462.716118516455, 570.0, 576.6391316493157, 582.5019608234983, 627.9277883043509, 673.8248055505604, 3677.4667673187773, 3957.960420395817, 4166.106036368744, 4222.239996800606, 4241.236577416094, 53990.73004634952, 58347.70826145842, 58400.41599584035, 58579.70710146507, 58716.11925821116, 49744.75127624339, 50080.0, 50799.492005079475, 50807.0, 50880.0, 44436.11127777426, 44557.777211114386, 45223.09553808905, 46676.59970200899, 46801.76599116983, 8136.83726325482, 8502.022267439077, 8502.617382217939, 8518.403711740119, 8574.030122550206, 35026.64973350336, 35506.0, 35852.0, 36060.27879442449, 36382.09044773902, 42403.7879810599, 45372.09255814799, 45390.54609453863, 45628.31557526573, 45646.837676913194, 10695.5187016586, 10784.622538211124, 10846.186536009673, 10916.672499825017, 11104.833427498756, 11375.886241137483, 11602.535898563963, 11605.88394116048, 11616.128790340927, 11628.709282268012, 10764.40795756241, 10773.89226107729, 10851.782964340828, 10888.18338624622, 10889.401082940198, 10428.478576071015, 10571.5242814072, 10699.89300106989, 10765.192610554397, 10873.78252434931, 10731.570737170427, 10788.514516846604, 10843.783124337311, 10914.126869850552, 10937.179711521827, 8259.256666900008, 8309.709160179365, 8446.113158118555, 8496.447730897471, 8560.700375486827, 8873.334499912404, 8992.86510702353, 9214.430426146451, 9284.622560987564, 9413.34106612558], "unit": "score", "name": "yui.html", "value": 6238.766496016097}], "name": "dromaeo_css", "value": 6791.937903986151}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 105.0, 110.0, 108.0, 110.0, 110.0, 112.0, 105.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 153.0, 169.0, 125.0, 147.0, 154.0, 131.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 118.0, 96.0, 73.0, 73.0, 74.0, 106.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 135.0, 96.0, 96.0, 97.0, 141.0, 96.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 69.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 83.0, 83.0, 90.0, 87.0, 81.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [117.0, 120.0, 117.0, 125.0, 126.0, 123.0, 125.0, 119.0, 123.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [146.0, 132.0, 147.0, 142.0, 143.0, 130.0, 145.0, 154.0, 149.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 68.0, 66.0, 69.0, 79.0, 66.0, 66.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1500.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.58337497917708], "unit": "score", "name": "Richards", "value": 211.91790600000007}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [776.3975155279503], "unit": "score", "name": "Earley", "value": 858.4043439999999}, {"lowerIsBetter": false, "replicates": [12456.79012345679], "unit": "score", "name": "Boyer", "value": 53.501985133795806}, {"lowerIsBetter": false, "replicates": [41693.87755102041], "unit": "score", "name": "RegExp", "value": 21.849371023005364}, {"lowerIsBetter": false, "replicates": [568.1946802490096], "unit": "score", "name": "Splay", "value": 143.4209133466136}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19043.077982503797}]} 21:31:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19043.08"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1500.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6791.94"}}} 21:31:37 INFO - Return code: 0 21:31:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 21:31:37 INFO - # TBPL SUCCESS # 21:31:37 INFO - Running post-action listener: _resource_record_post_action 21:31:37 INFO - Running post-run listener: _resource_record_post_run 21:31:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 24576; Write bytes: 539914240; Read time: 308; Write time: 498576 21:31:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 236449792; Read time: 140; Write time: 273368 21:31:38 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 302727168; Read time: 168; Write time: 225200 21:31:38 INFO - Running post-run listener: _upload_blobber_files 21:31:38 INFO - Blob upload gear active. 21:31:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 21:31:38 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 21:31:38 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 21:31:38 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 21:31:38 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 21:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:40 INFO - (blobuploader) - INFO - Done attempting. 21:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:40 INFO - (blobuploader) - INFO - Done attempting. 21:31:40 INFO - (blobuploader) - INFO - Iteration through files over. 21:31:40 INFO - Return code: 0 21:31:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 21:31:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 21:31:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4abd9ac3b7dd40e6f2f06c1abfc8c4d582e8c09dc9925fbf72a0d8080ee6d5a7b7fb5964bfc8274f0c1ae3d752d443dd45a4b84876c27b9d3fb486ce1f5b62de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4f6fa4d3f625ff3f5fd7cebcbe974925d0bf19f2272fd9ea4bd5ef13377fb14b8f819e186d4c09045a112fafa1842e26188529fb07d8046b748b1a07f4f7858"} 21:31:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 21:31:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 21:31:40 INFO - Contents: 21:31:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4abd9ac3b7dd40e6f2f06c1abfc8c4d582e8c09dc9925fbf72a0d8080ee6d5a7b7fb5964bfc8274f0c1ae3d752d443dd45a4b84876c27b9d3fb486ce1f5b62de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4f6fa4d3f625ff3f5fd7cebcbe974925d0bf19f2272fd9ea4bd5ef13377fb14b8f819e186d4c09045a112fafa1842e26188529fb07d8046b748b1a07f4f7858"} 21:31:40 INFO - Running post-run listener: copy_logs_to_upload_dir 21:31:40 INFO - Copying logs to upload dir... 21:31:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 21:31:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.671771 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-20 21:31:41.125405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:41.128429) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4abd9ac3b7dd40e6f2f06c1abfc8c4d582e8c09dc9925fbf72a0d8080ee6d5a7b7fb5964bfc8274f0c1ae3d752d443dd45a4b84876c27b9d3fb486ce1f5b62de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4f6fa4d3f625ff3f5fd7cebcbe974925d0bf19f2272fd9ea4bd5ef13377fb14b8f819e186d4c09045a112fafa1842e26188529fb07d8046b748b1a07f4f7858"} build_url:https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/TLkBfIm_Spqv2fxVLzh-Rg/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/Fx-Team/sha512/4abd9ac3b7dd40e6f2f06c1abfc8c4d582e8c09dc9925fbf72a0d8080ee6d5a7b7fb5964bfc8274f0c1ae3d752d443dd45a4b84876c27b9d3fb486ce1f5b62de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4f6fa4d3f625ff3f5fd7cebcbe974925d0bf19f2272fd9ea4bd5ef13377fb14b8f819e186d4c09045a112fafa1842e26188529fb07d8046b748b1a07f4f7858"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:41.162552) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:41.162878) ========= 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=03627c79f6bb3d1578c4a402000001ba-1453352449.521239-55554017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 21:31:41.539295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 21:31:41.539630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 21:31:41.540121) ========= ========= Total master_lag: 0.67 =========