builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1453421678.11 results: success (0) buildid: 20160121133008 builduid: 7515148033b44f3f91b5587fc2420426 revision: fa6b5ffdd329775f0bb361a2c036625fd71c49fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.106204) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.106768) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.107059) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006332 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.130334) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.130707) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.144318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.144730) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.193501) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.193836) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.194244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.194526) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 16:14:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.3M=0s 2016-01-21 16:14:38 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.364740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.365046) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020116 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.414169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:38.414475) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fa6b5ffdd329775f0bb361a2c036625fd71c49fe --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/mozilla-inbound --rev fa6b5ffdd329775f0bb361a2c036625fd71c49fe --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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 16:14:38,931 truncating revision to first 12 chars 2016-01-21 16:14:38,932 Setting DEBUG logging. 2016-01-21 16:14:38,932 attempt 1/10 2016-01-21 16:14:38,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fa6b5ffdd329?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 16:14:39,228 unpacking tar archive at: mozilla-inbound-fa6b5ffdd329/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:39.008287) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:39.008622) ========= echo fa6b5ffdd329775f0bb361a2c036625fd71c49fe in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fa6b5ffdd329775f0bb361a2c036625fd71c49fe'] 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fa6b5ffdd329775f0bb361a2c036625fd71c49fe program finished with exit code 0 elapsedTime=0.003130 script_repo_revision: 'fa6b5ffdd329775f0bb361a2c036625fd71c49fe' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:39.081312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:39.081631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 16:14:39.091345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-21 16:14:39.091623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:14:39 INFO - MultiFileLogger online at 20160121 16:14:39 in /builds/slave/test-pgo 16:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:14:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:14:39 INFO - {'append_to_log': False, 16:14:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:14:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:14:39 INFO - 'branch': 'Mozilla-Inbound', 16:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:39 INFO - 'config_files': ('talos/linux_config.py',), 16:14:39 INFO - 'default_actions': ('clobber', 16:14:39 INFO - 'read-buildbot-config', 16:14:39 INFO - 'download-and-extract', 16:14:39 INFO - 'populate-webroot', 16:14:39 INFO - 'create-virtualenv', 16:14:39 INFO - 'install', 16:14:39 INFO - 'run-tests'), 16:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:39 INFO - 'download_minidump_stackwalk': True, 16:14:39 INFO - 'download_symbols': 'ondemand', 16:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:39 INFO - 'installer_path': 'installer.exe', 16:14:39 INFO - 'log_level': 'info', 16:14:39 INFO - 'log_name': 'talos', 16:14:39 INFO - 'log_to_console': True, 16:14:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:14:39 INFO - 'opt_config_files': (), 16:14:39 INFO - 'pip_index': False, 16:14:39 INFO - 'sps_profile': False, 16:14:39 INFO - 'sps_profile_interval': 0, 16:14:39 INFO - 'suite': 'dromaeojs-e10s', 16:14:39 INFO - 'system_bits': '32', 16:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:39 INFO - 'title': 'talos-linux64-ix-010', 16:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:39 INFO - 'use_talos_json': True, 16:14:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:39 INFO - 'work_dir': 'build'} 16:14:39 INFO - ##### 16:14:39 INFO - ##### Running clobber step. 16:14:39 INFO - ##### 16:14:39 INFO - Running pre-action listener: _resource_record_pre_action 16:14:39 INFO - Running main action method: clobber 16:14:39 INFO - rmtree: /builds/slave/test-pgo/build 16:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:14:40 INFO - Running post-action listener: _resource_record_post_action 16:14:40 INFO - ##### 16:14:40 INFO - ##### Running read-buildbot-config step. 16:14:40 INFO - ##### 16:14:40 INFO - Running pre-action listener: _resource_record_pre_action 16:14:40 INFO - Running main action method: read_buildbot_config 16:14:40 INFO - Using buildbot properties: 16:14:40 INFO - { 16:14:40 INFO - "project": "", 16:14:40 INFO - "product": "firefox", 16:14:40 INFO - "script_repo_revision": "production", 16:14:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:14:40 INFO - "repository": "", 16:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:14:40 INFO - "buildid": "20160121133008", 16:14:40 INFO - "pgo_build": "True", 16:14:40 INFO - "basedir": "/builds/slave/test-pgo", 16:14:40 INFO - "buildnumber": 638, 16:14:40 INFO - "slavename": "talos-linux64-ix-010", 16:14:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:14:40 INFO - "platform": "ubuntu64_hw", 16:14:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:14:40 INFO - "branch": "mozilla-inbound", 16:14:40 INFO - "repo_path": "integration/mozilla-inbound", 16:14:40 INFO - "revision": "fa6b5ffdd329775f0bb361a2c036625fd71c49fe", 16:14:40 INFO - "stage_platform": "linux64-pgo", 16:14:40 INFO - "builduid": "7515148033b44f3f91b5587fc2420426", 16:14:40 INFO - "slavebuilddir": "test" 16:14:40 INFO - } 16:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:14:40 INFO - Running post-action listener: _resource_record_post_action 16:14:40 INFO - ##### 16:14:40 INFO - ##### Running download-and-extract step. 16:14:40 INFO - ##### 16:14:40 INFO - Running pre-action listener: _resource_record_pre_action 16:14:40 INFO - Running main action method: download_and_extract 16:14:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:14: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')]} 16:14:40 INFO - https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/test_packages.json 16:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/test_packages.json 16:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:14:40 INFO - Downloaded 1448 bytes. 16:14:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:14:40 INFO - Using the following test package requirements: 16:14:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:14:40 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:14:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'jsshell-linux-x86_64.zip'], 16:14:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:14:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:14:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:14:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:14:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:14:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:14: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')]} 16:14:40 INFO - https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:43 INFO - Downloaded 22486637 bytes. 16:14:43 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'] 16:14:43 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 16:14:44 INFO - Return code: 0 16:14:44 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 16:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:44 INFO - https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:14:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:14:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:14:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:46 INFO - Downloaded 22486637 bytes. 16:14:46 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'] 16:14:46 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 16:14:48 INFO - Return code: 0 16:14:48 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')]} 16:14:48 INFO - https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:49 INFO - Downloaded 10705515 bytes. 16:14:49 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'] 16:14:49 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 16:14:49 INFO - Return code: 0 16:14: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')]} 16:14:49 INFO - https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RyP6cdJsRbalTbnc-ZT_4w/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 16:14:50 INFO - Downloaded 55964887 bytes. 16:14:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:14:50 INFO - mkdir: /builds/slave/test-pgo/properties 16:14:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:14:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:14:50 INFO - Contents: 16:14:50 INFO - build_url:https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:14:50 INFO - Running post-action listener: _resource_record_post_action 16:14:50 INFO - Running post-action listener: set_extra_try_arguments 16:14:50 INFO - ##### 16:14:50 INFO - ##### Running populate-webroot step. 16:14:50 INFO - ##### 16:14:50 INFO - Running pre-action listener: _resource_record_pre_action 16:14:50 INFO - Running main action method: populate_webroot 16:14:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:50 INFO - '--tppagecycles', 16:14:50 INFO - '7'], 16:14:50 INFO - 'tests': ['tsvgm']}}, 16:14:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:14:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:14:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:14:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'tests': ['damp', 'tps']}, 16:14:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['damp', 'tps']}, 16:14:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:14:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:50 INFO - 'other': {'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'other_l64': {'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'other_nol64': {'tests': ['a11yr', 16:14:50 INFO - 'ts_paint', 16:14:50 INFO - 'tpaint', 16:14:50 INFO - 'sessionrestore', 16:14:50 INFO - 'sessionrestore_no_auto_restore']}, 16:14:50 INFO - 'svgr': {'tests': ['tsvgx', 16:14:50 INFO - 'tsvgr_opacity', 16:14:50 INFO - 'tart', 16:14:50 INFO - 'tscrollx', 16:14:50 INFO - 'cart']}, 16:14:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['tsvgx', 16:14:50 INFO - 'tsvgr_opacity', 16:14:50 INFO - 'tart', 16:14:50 INFO - 'tscrollx', 16:14:50 INFO - 'cart']}, 16:14:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'tests': ['tp5o']}, 16:14:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'talos_options': ['--e10s'], 16:14:50 INFO - 'tests': ['tp5o']}, 16:14:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'talos_options': ['--xperf_path', 16:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:50 INFO - 'tests': ['tp5n']}, 16:14:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:50 INFO - 'talos_options': ['--e10s', 16:14:50 INFO - '--xperf_path', 16:14:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:50 INFO - 'tests': ['tp5n']}}, 16:14:50 INFO - 'talos.zip': {'path': '', 16:14:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:50 INFO - Running post-action listener: _resource_record_post_action 16:14:50 INFO - ##### 16:14:50 INFO - ##### Running create-virtualenv step. 16:14:50 INFO - ##### 16:14:50 INFO - Running pre-action listener: _resource_record_pre_action 16:14:50 INFO - Running main action method: create_virtualenv 16:14:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:14:50 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 16:14:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:14:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:50 INFO - Using real prefix '/usr' 16:14:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:14:51 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:53 INFO - Installing pip.................done. 16:14:53 INFO - Return code: 0 16:14:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:14:53 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')]} 16:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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')]} 16:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:14:53 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 16:14:53 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 16:14:53 INFO - Using env: {'DISPLAY': ':0', 16:14:53 INFO - 'HOME': '/home/cltbld', 16:14:53 INFO - 'LANG': 'en_US.UTF-8', 16:14:53 INFO - 'LANGUAGE': 'en_US:en', 16:14:53 INFO - 'LOGNAME': 'cltbld', 16:14:53 INFO - 'MAIL': '/var/mail/cltbld', 16:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:53 INFO - 'MOZ_NO_REMOTE': '1', 16:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:53 INFO - 'NO_EM_RESTART': '1', 16:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:14:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:14:53 INFO - 'SHELL': '/bin/bash', 16:14:53 INFO - 'SHLVL': '1', 16:14:53 INFO - 'TERM': 'linux', 16:14:53 INFO - 'TMOUT': '86400', 16:14:53 INFO - 'USER': 'cltbld', 16:14:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:53 INFO - '_': '/tools/buildbot/bin/python'} 16:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:53 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 16:14:53 INFO - Cleaning up... 16:14:53 INFO - Return code: 0 16:14:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:14:53 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')]} 16:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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')]} 16:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:53 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:14:53 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 16:14:53 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 16:14:53 INFO - Using env: {'DISPLAY': ':0', 16:14:53 INFO - 'HOME': '/home/cltbld', 16:14:53 INFO - 'LANG': 'en_US.UTF-8', 16:14:53 INFO - 'LANGUAGE': 'en_US:en', 16:14:53 INFO - 'LOGNAME': 'cltbld', 16:14:53 INFO - 'MAIL': '/var/mail/cltbld', 16:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:53 INFO - 'MOZ_NO_REMOTE': '1', 16:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:53 INFO - 'NO_EM_RESTART': '1', 16:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:14:53 INFO - 'PWD': '/builds/slave/test-pgo', 16:14:53 INFO - 'SHELL': '/bin/bash', 16:14:53 INFO - 'SHLVL': '1', 16:14:53 INFO - 'TERM': 'linux', 16:14:53 INFO - 'TMOUT': '86400', 16:14:53 INFO - 'USER': 'cltbld', 16:14:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:53 INFO - '_': '/tools/buildbot/bin/python'} 16:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:53 INFO - Downloading/unpacking psutil>=0.7.1 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:53 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 16:14:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:55 INFO - Installing collected packages: psutil 16:14:55 INFO - Running setup.py install for psutil 16:14:55 INFO - building 'psutil._psutil_linux' extension 16:14:55 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 16:14:55 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 16:14:55 INFO - building 'psutil._psutil_posix' extension 16:14:55 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 16:14:55 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 16:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:56 INFO - Successfully installed psutil 16:14:56 INFO - Cleaning up... 16:14:56 INFO - Return code: 0 16:14:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:56 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:14:56 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 16:14:56 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 16:14:56 INFO - Using env: {'DISPLAY': ':0', 16:14:56 INFO - 'HOME': '/home/cltbld', 16:14:56 INFO - 'LANG': 'en_US.UTF-8', 16:14:56 INFO - 'LANGUAGE': 'en_US:en', 16:14:56 INFO - 'LOGNAME': 'cltbld', 16:14:56 INFO - 'MAIL': '/var/mail/cltbld', 16:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:56 INFO - 'MOZ_NO_REMOTE': '1', 16:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:56 INFO - 'NO_EM_RESTART': '1', 16:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:14:56 INFO - 'PWD': '/builds/slave/test-pgo', 16:14:56 INFO - 'SHELL': '/bin/bash', 16:14:56 INFO - 'SHLVL': '1', 16:14:56 INFO - 'TERM': 'linux', 16:14:56 INFO - 'TMOUT': '86400', 16:14:56 INFO - 'USER': 'cltbld', 16:14:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:56 INFO - '_': '/tools/buildbot/bin/python'} 16:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:56 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 16:14:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:14:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:14:58 INFO - Installing collected packages: mozsystemmonitor 16:14:58 INFO - Running setup.py install for mozsystemmonitor 16:14:58 INFO - Successfully installed mozsystemmonitor 16:14:58 INFO - Cleaning up... 16:14:58 INFO - Return code: 0 16:14:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:14: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')]} 16:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:58 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:14:58 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 16:14:58 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 16:14:58 INFO - Using env: {'DISPLAY': ':0', 16:14:58 INFO - 'HOME': '/home/cltbld', 16:14:58 INFO - 'LANG': 'en_US.UTF-8', 16:14:58 INFO - 'LANGUAGE': 'en_US:en', 16:14:58 INFO - 'LOGNAME': 'cltbld', 16:14:58 INFO - 'MAIL': '/var/mail/cltbld', 16:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:58 INFO - 'MOZ_NO_REMOTE': '1', 16:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:58 INFO - 'NO_EM_RESTART': '1', 16:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:14:58 INFO - 'PWD': '/builds/slave/test-pgo', 16:14:58 INFO - 'SHELL': '/bin/bash', 16:14:58 INFO - 'SHLVL': '1', 16:14:58 INFO - 'TERM': 'linux', 16:14:58 INFO - 'TMOUT': '86400', 16:14:58 INFO - 'USER': 'cltbld', 16:14:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:58 INFO - '_': '/tools/buildbot/bin/python'} 16:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:58 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:14:58 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 16:15:00 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:15:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:00 INFO - Downloading docopt-0.6.1.tar.gz 16:15:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:00 INFO - Running setup.py install for blobuploader 16:15:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:15:01 INFO - Running setup.py install for requests 16:15:01 INFO - Running setup.py install for docopt 16:15:01 INFO - Successfully installed blobuploader requests docopt 16:15:01 INFO - Cleaning up... 16:15:01 INFO - Return code: 0 16:15:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:01 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:15:01 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 16:15:01 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 16:15:01 INFO - Using env: {'DISPLAY': ':0', 16:15:01 INFO - 'HOME': '/home/cltbld', 16:15:01 INFO - 'LANG': 'en_US.UTF-8', 16:15:01 INFO - 'LANGUAGE': 'en_US:en', 16:15:01 INFO - 'LOGNAME': 'cltbld', 16:15:01 INFO - 'MAIL': '/var/mail/cltbld', 16:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:01 INFO - 'MOZ_NO_REMOTE': '1', 16:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:01 INFO - 'NO_EM_RESTART': '1', 16:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:01 INFO - 'SHELL': '/bin/bash', 16:15:01 INFO - 'SHLVL': '1', 16:15:01 INFO - 'TERM': 'linux', 16:15:01 INFO - 'TMOUT': '86400', 16:15:01 INFO - 'USER': 'cltbld', 16:15:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:01 INFO - '_': '/tools/buildbot/bin/python'} 16:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:15:01 INFO - Running setup.py (path:/tmp/pip-Gaw_2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:15:01 INFO - Running setup.py (path:/tmp/pip-k_Rf9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:15:01 INFO - Running setup.py (path:/tmp/pip-3PMGHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:15:02 INFO - Running setup.py (path:/tmp/pip-40TpSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:15:02 INFO - Running setup.py (path:/tmp/pip-NPx4uW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:15:02 INFO - Running setup.py (path:/tmp/pip-otWZao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:15:02 INFO - Running setup.py (path:/tmp/pip-WT6Vp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:15:02 INFO - Running setup.py (path:/tmp/pip-rz80o8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:15:02 INFO - Running setup.py (path:/tmp/pip-yz4Pk7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:15:02 INFO - Running setup.py (path:/tmp/pip-JxhPul-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:15:02 INFO - Running setup.py (path:/tmp/pip-x5V3Eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:15:02 INFO - Running setup.py (path:/tmp/pip-PW9TlB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:15:02 INFO - Running setup.py (path:/tmp/pip-3ntxEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:15:02 INFO - Running setup.py (path:/tmp/pip-97SUn0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:15:02 INFO - Running setup.py (path:/tmp/pip-Sl9LSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:15:02 INFO - Running setup.py (path:/tmp/pip-1pf67o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:15:02 INFO - Running setup.py (path:/tmp/pip-LlxLXc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:15:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:03 INFO - Running setup.py install for manifestparser 16:15:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Running setup.py install for mozcrash 16:15:03 INFO - Running setup.py install for mozdebug 16:15:03 INFO - Running setup.py install for mozdevice 16:15:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Running setup.py install for mozfile 16:15:03 INFO - Running setup.py install for mozhttpd 16:15:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Running setup.py install for mozinfo 16:15:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Running setup.py install for mozInstall 16:15:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:15:03 INFO - Running setup.py install for mozleak 16:15:03 INFO - Running setup.py install for mozlog 16:15:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Running setup.py install for moznetwork 16:15:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Running setup.py install for mozprocess 16:15:04 INFO - Running setup.py install for mozprofile 16:15:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Running setup.py install for mozrunner 16:15:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Running setup.py install for mozscreenshot 16:15:04 INFO - Running setup.py install for moztest 16:15:04 INFO - Running setup.py install for mozversion 16:15:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:15:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:04 INFO - Cleaning up... 16:15:04 INFO - Return code: 0 16:15:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:15: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')]} 16:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15: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')]} 16:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:04 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:15:04 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 16:15:04 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 16:15:04 INFO - Using env: {'DISPLAY': ':0', 16:15:04 INFO - 'HOME': '/home/cltbld', 16:15:04 INFO - 'LANG': 'en_US.UTF-8', 16:15:04 INFO - 'LANGUAGE': 'en_US:en', 16:15:04 INFO - 'LOGNAME': 'cltbld', 16:15:04 INFO - 'MAIL': '/var/mail/cltbld', 16:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:04 INFO - 'MOZ_NO_REMOTE': '1', 16:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:04 INFO - 'NO_EM_RESTART': '1', 16:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:04 INFO - 'SHELL': '/bin/bash', 16:15:04 INFO - 'SHLVL': '1', 16:15:04 INFO - 'TERM': 'linux', 16:15:04 INFO - 'TMOUT': '86400', 16:15:04 INFO - 'USER': 'cltbld', 16:15:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:04 INFO - '_': '/tools/buildbot/bin/python'} 16:15:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:15:04 INFO - Running setup.py (path:/tmp/pip-a2MSNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:15:05 INFO - Running setup.py (path:/tmp/pip-15BZPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:15:05 INFO - Running setup.py (path:/tmp/pip-tMbWUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:15:05 INFO - Running setup.py (path:/tmp/pip-mZxCai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:15:05 INFO - Running setup.py (path:/tmp/pip-IPau1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:15:05 INFO - Running setup.py (path:/tmp/pip-EQLd85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:15:05 INFO - Running setup.py (path:/tmp/pip-GU5TN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:15:05 INFO - Running setup.py (path:/tmp/pip-iOPzML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:15:05 INFO - Running setup.py (path:/tmp/pip-g9zA8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:15:05 INFO - Running setup.py (path:/tmp/pip-1pBfCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:15:05 INFO - Running setup.py (path:/tmp/pip-Cu556S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:15:05 INFO - Running setup.py (path:/tmp/pip-mH3_Wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:15:05 INFO - Running setup.py (path:/tmp/pip-9YsxRq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:15:05 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)) 16:15:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:15:05 INFO - Running setup.py (path:/tmp/pip-GPsJiY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:15:06 INFO - Running setup.py (path:/tmp/pip-xKnzhm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:15:06 INFO - Running setup.py (path:/tmp/pip-uTMm9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:15:06 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)) 16:15:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:15:06 INFO - Running setup.py (path:/tmp/pip-ICO0Xe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 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)) 16:15:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:07 INFO - Downloading blessings-1.6.tar.gz 16:15:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:08 INFO - Installing collected packages: blessings 16:15:08 INFO - Running setup.py install for blessings 16:15:08 INFO - Successfully installed blessings 16:15:08 INFO - Cleaning up... 16:15:08 INFO - Return code: 0 16:15:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:15:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:15:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:15:08 INFO - Reading from file tmpfile_stdout 16:15:08 INFO - Current package versions: 16:15:08 INFO - argparse == 1.2.1 16:15:08 INFO - blessings == 1.6 16:15:08 INFO - blobuploader == 1.2.4 16:15:08 INFO - docopt == 0.6.1 16:15:08 INFO - manifestparser == 1.1 16:15:08 INFO - mozInstall == 1.12 16:15:08 INFO - mozcrash == 0.16 16:15:08 INFO - mozdebug == 0.1 16:15:08 INFO - mozdevice == 0.48 16:15:08 INFO - mozfile == 1.2 16:15:08 INFO - mozhttpd == 0.7 16:15:08 INFO - mozinfo == 0.9 16:15:08 INFO - mozleak == 0.1 16:15:08 INFO - mozlog == 3.1 16:15:08 INFO - moznetwork == 0.27 16:15:08 INFO - mozprocess == 0.22 16:15:08 INFO - mozprofile == 0.28 16:15:08 INFO - mozrunner == 6.11 16:15:08 INFO - mozscreenshot == 0.1 16:15:08 INFO - mozsystemmonitor == 0.0 16:15:08 INFO - moztest == 0.7 16:15:08 INFO - mozversion == 1.4 16:15:08 INFO - psutil == 3.1.1 16:15:08 INFO - requests == 1.2.3 16:15:08 INFO - wsgiref == 0.1.2 16:15:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:15:08 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')]} 16:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 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')]} 16:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:15:08 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 16:15:08 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 16:15:08 INFO - Using env: {'DISPLAY': ':0', 16:15:08 INFO - 'HOME': '/home/cltbld', 16:15:08 INFO - 'LANG': 'en_US.UTF-8', 16:15:08 INFO - 'LANGUAGE': 'en_US:en', 16:15:08 INFO - 'LOGNAME': 'cltbld', 16:15:08 INFO - 'MAIL': '/var/mail/cltbld', 16:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:08 INFO - 'MOZ_NO_REMOTE': '1', 16:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:08 INFO - 'NO_EM_RESTART': '1', 16:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:08 INFO - 'SHELL': '/bin/bash', 16:15:08 INFO - 'SHLVL': '1', 16:15:08 INFO - 'TERM': 'linux', 16:15:08 INFO - 'TMOUT': '86400', 16:15:08 INFO - 'USER': 'cltbld', 16:15:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:08 INFO - '_': '/tools/buildbot/bin/python'} 16:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 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)) 16:15:08 INFO - Cleaning up... 16:15:08 INFO - Return code: 0 16:15:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:15:08 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')]} 16:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 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')]} 16:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:15:08 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 16:15:08 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 16:15:08 INFO - Using env: {'DISPLAY': ':0', 16:15:08 INFO - 'HOME': '/home/cltbld', 16:15:08 INFO - 'LANG': 'en_US.UTF-8', 16:15:08 INFO - 'LANGUAGE': 'en_US:en', 16:15:08 INFO - 'LOGNAME': 'cltbld', 16:15:08 INFO - 'MAIL': '/var/mail/cltbld', 16:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:08 INFO - 'MOZ_NO_REMOTE': '1', 16:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:08 INFO - 'NO_EM_RESTART': '1', 16:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:08 INFO - 'SHELL': '/bin/bash', 16:15:08 INFO - 'SHLVL': '1', 16:15:08 INFO - 'TERM': 'linux', 16:15:08 INFO - 'TMOUT': '86400', 16:15:08 INFO - 'USER': 'cltbld', 16:15:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:08 INFO - '_': '/tools/buildbot/bin/python'} 16:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:08 INFO - Downloading/unpacking jsonschema 16:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:10 INFO - Downloading/unpacking functools32 (from jsonschema) 16:15:10 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 16:15:10 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 16:15:10 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 16:15:10 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 16:15:10 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 16:15:10 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 16:15:10 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:10 INFO - warning: no files found matching '*.txt' 16:15:10 INFO - no previously-included directories found matching 'build' 16:15:10 INFO - no previously-included directories found matching 'dist' 16:15:10 INFO - no previously-included directories found matching '.git*' 16:15:10 INFO - Installing collected packages: jsonschema, functools32 16:15:11 INFO - Running setup.py install for functools32 16:15:11 INFO - warning: no files found matching '*.txt' 16:15:11 INFO - no previously-included directories found matching 'build' 16:15:11 INFO - no previously-included directories found matching 'dist' 16:15:11 INFO - no previously-included directories found matching '.git*' 16:15:11 INFO - Successfully installed jsonschema functools32 16:15:11 INFO - Cleaning up... 16:15:11 INFO - Return code: 0 16:15:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:15:11 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')]} 16:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:11 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')]} 16:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:11 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 0x7f8a6aeedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, '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': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', '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 16:15:11 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 16:15:11 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 16:15:11 INFO - Using env: {'DISPLAY': ':0', 16:15:11 INFO - 'HOME': '/home/cltbld', 16:15:11 INFO - 'LANG': 'en_US.UTF-8', 16:15:11 INFO - 'LANGUAGE': 'en_US:en', 16:15:11 INFO - 'LOGNAME': 'cltbld', 16:15:11 INFO - 'MAIL': '/var/mail/cltbld', 16:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:11 INFO - 'MOZ_NO_REMOTE': '1', 16:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:11 INFO - 'NO_EM_RESTART': '1', 16:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:11 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:11 INFO - 'SHELL': '/bin/bash', 16:15:11 INFO - 'SHLVL': '1', 16:15:11 INFO - 'TERM': 'linux', 16:15:11 INFO - 'TMOUT': '86400', 16:15:11 INFO - 'USER': 'cltbld', 16:15:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:11 INFO - '_': '/tools/buildbot/bin/python'} 16:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:11 INFO - Downloading/unpacking flake8 16:15:11 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 16:15:11 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 16:15:11 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 16:15:11 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 16:15:11 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 16:15:11 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 16:15:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:15:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:15:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 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 16:15:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:13 INFO - no previously-included directories found matching 'docs/_build' 16:15:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:15:13 INFO - Running setup.py install for pep8 16:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:13 INFO - no previously-included directories found matching 'docs/_build' 16:15:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:15:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:15:13 INFO - Cleaning up... 16:15:14 INFO - Return code: 0 16:15:14 INFO - Running post-action listener: _resource_record_post_action 16:15:14 INFO - Running post-action listener: _start_resource_monitoring 16:15:14 INFO - Starting resource monitoring. 16:15:14 INFO - ##### 16:15:14 INFO - ##### Running install step. 16:15:14 INFO - ##### 16:15:14 INFO - Running pre-action listener: _resource_record_pre_action 16:15:14 INFO - Running main action method: install 16:15:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:15:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:15:14 INFO - Reading from file tmpfile_stdout 16:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:15:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:15:14 INFO - Reading from file tmpfile_stdout 16:15:14 INFO - Output received: 16:15:14 INFO - Usage: mozinstall [options] installer 16:15:14 INFO - Options: 16:15:14 INFO - -h, --help show this help message and exit 16:15:14 INFO - -d DEST, --destination=DEST 16:15:14 INFO - Directory to install application into. [default: 16:15:14 INFO - "/builds/slave/test-pgo"] 16:15:14 INFO - --app=APP Application being installed. [default: firefox] 16:15:14 INFO - mkdir: /builds/slave/test-pgo/build/application 16:15:14 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'] 16:15:14 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 16:15:30 INFO - Reading from file tmpfile_stdout 16:15:30 INFO - Output received: 16:15:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:15:30 INFO - Running post-action listener: _resource_record_post_action 16:15:30 INFO - ##### 16:15:30 INFO - ##### Running run-tests step. 16:15:30 INFO - ##### 16:15:30 INFO - Running pre-action listener: _resource_record_pre_action 16:15:30 INFO - Running main action method: run_tests 16:15:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:15:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:15:30 INFO - Python 2.7.3 16:15:30 INFO - Return code: 0 16:15:30 INFO - grabbing minidump binary from tooltool 16:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:30 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 0x1d5f7f0>, '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 0x1ccb2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccb760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:15:30 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 16:15:30 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 16:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:30 INFO - Return code: 0 16:15:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:15:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:15:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:15:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:15:31 INFO - Return code: 0 16:15:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:15:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:15:31 INFO - Using env: {'DISPLAY': ':0', 16:15:31 INFO - 'HOME': '/home/cltbld', 16:15:31 INFO - 'LANG': 'en_US.UTF-8', 16:15:31 INFO - 'LANGUAGE': 'en_US:en', 16:15:31 INFO - 'LOGNAME': 'cltbld', 16:15:31 INFO - 'MAIL': '/var/mail/cltbld', 16:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:31 INFO - 'MOZ_NO_REMOTE': '1', 16:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:31 INFO - 'NO_EM_RESTART': '1', 16:15:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:15:31 INFO - 'PWD': '/builds/slave/test-pgo', 16:15:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:15:31 INFO - 'SHELL': '/bin/bash', 16:15:31 INFO - 'SHLVL': '1', 16:15:31 INFO - 'TERM': 'linux', 16:15:31 INFO - 'TMOUT': '86400', 16:15:31 INFO - 'USER': 'cltbld', 16:15:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514', 16:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:31 INFO - '_': '/tools/buildbot/bin/python'} 16:15:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:15:31 INFO - mozversion application_buildid: 20160121133008 16:15:31 INFO - mozversion application_changeset: fa6b5ffdd329775f0bb361a2c036625fd71c49fe 16:15:31 INFO - mozversion application_display_name: Nightly 16:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:31 INFO - mozversion application_name: Firefox 16:15:31 INFO - mozversion application_remotingname: firefox 16:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:15:31 INFO - mozversion application_vendor: Mozilla 16:15:31 INFO - mozversion application_version: 46.0a1 16:15:31 INFO - mozversion platform_buildid: 20160121133008 16:15:31 INFO - mozversion platform_changeset: fa6b5ffdd329775f0bb361a2c036625fd71c49fe 16:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:15:31 INFO - mozversion platform_version: 46.0a1 16:15:31 INFO - using testdate: 1453421731 16:15:31 INFO - actual date: 1453421731 16:15:31 INFO - starting webserver on 'localhost:32786' 16:15:31 INFO - SUITE-START | Running 3 tests 16:15:31 INFO - TEST-START | dromaeo_css 16:15:31 INFO - operating with platform_type : linux_ 16:15:31 INFO - Initialising browser for dromaeo_css test... 16:15:31 INFO - TEST-INFO | started process 6701 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprmHgfz/profile http://localhost:32786/getInfo.html) 16:15:35 INFO - PROCESS | 6701 | 16:15:35 INFO - PROCESS | 6701 | (process:6784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:15:36 INFO - PROCESS | 6701 | __metrics Screen width/height:1600/1200 16:15:36 INFO - PROCESS | 6701 | colorDepth:24 16:15:36 INFO - PROCESS | 6701 | Browser inner width/height: 1024/697 16:15:36 INFO - PROCESS | 6701 | __metrics 16:15:36 INFO - PROCESS | 6701 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:15:37 INFO - TEST-INFO | 6701: exit 0 16:15:37 INFO - Browser initialized. 16:15:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:37 INFO - TEST-INFO | started process 6833 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprmHgfz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:39 INFO - PROCESS | 6833 | 16:15:39 INFO - PROCESS | 6833 | (process:6891): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:15:49 INFO - PROCESS | 6833 | RSS: Main: 153681920 16:15:49 INFO - PROCESS | 6833 | 16:16:39 INFO - PROCESS | 6833 | 1453421799269 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] 16:18:48 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32786/tests/dromaeo/cssquery-ext.html) 16:18:49 INFO - PROCESS | 6833 | RSS: Main: 161984512 16:18:49 INFO - PROCESS | 6833 | 16:21:51 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-ext.html (next: http://localhost:32786/tests/dromaeo/cssquery-jquery.html) 16:21:51 INFO - PROCESS | 6833 | RSS: Main: 158097408 16:21:51 INFO - PROCESS | 6833 | 16:24:53 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32786/tests/dromaeo/cssquery-mootools.html) 16:24:54 INFO - PROCESS | 6833 | RSS: Main: 159391744 16:24:54 INFO - PROCESS | 6833 | 16:27:55 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32786/tests/dromaeo/cssquery-prototype.html) 16:27:56 INFO - PROCESS | 6833 | RSS: Main: 156798976 16:27:56 INFO - PROCESS | 6833 | 16:30:58 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32786/tests/dromaeo/cssquery-yui.html) 16:30:59 INFO - PROCESS | 6833 | RSS: Main: 157270016 16:30:59 INFO - PROCESS | 6833 | 16:34:01 INFO - PROCESS | 6833 | Cycle 1(1): loaded http://localhost:32786/tests/dromaeo/cssquery-yui.html (next: http://localhost:32786/tests/dromaeo/cssquery-dojo.html) 16:34:01 INFO - PROCESS | 6833 | RSS: Main: 159248384 16:34:01 INFO - PROCESS | 6833 | 16:34:01 INFO - PROCESS | 6833 | __start_tp_report 16:34:01 INFO - PROCESS | 6833 | _x_x_mozilla_page_load 16:34:01 INFO - PROCESS | 6833 | _x_x_mozilla_page_load_details 16:34:01 INFO - PROCESS | 6833 | |i|pagename|runs| 16:34:01 INFO - PROCESS | 6833 | |0;dojo.html;3121.235297352149;3204.7115759581634;3226.4515032444483;3241.6920392562706;3254.1213872254493;5163.432022477534;5211.843644690656;5224.320838291022;5225.581953443725;5271.710055946922;5173.663711858727;5187.299714538536;5218.1650935850275;5243.711595862226;5253.57971362291;4749.90500189996;4759.262314341283;4802.687825291362;4809.7835597398025;4898.485659005806;4461.130079634472;4797.856064318076;4805.591524720386;4854.732989685566;4862.246351815475;4737.81048758051;4763.3807605011125;4804.783784729696;4825.131476334259;4841.225403935354;4779.068081724065;4815.253635686474;4816.012717392926;4820.132376172288;4822.7829747661435;4676.205045142334;4771.045790841811;4787.880302992418;4801.519848015206;4828.106800241966;5076.162433198518;5162.277281180638;5193.766280517386;5207.375114986188;5230.764615592308;5523.751431185607;5528.391876893538;5538.556915446755;5540.806071787509;5550.361708403545;5472.370677372113;5554.583406244547;5587.469190426903;5603.523700485463;5662.716864156817;5297.761600727977;5317.016351974897;5327.4139844616675;5329;5383.919241211385;5753.942460575341;5784.797532086357;5797.681127538026;5803.9419605803405;5812.593118481665;5517.393086760453;5528.364238112668;5582.162675598612;5582.804601838916;5593.720313984284;5547.667139971534;5555.861103472445;5565.471280228372;5571.609987300931;5584.21820945068;5487.039768040657;5528.44715528444;5536.972315138399;5538.141588053858;5540.7783688652;5473.698946557977;5475.890482190334;5519.613627046068;5586.86032849182;5600.803971860965;4353.564643535621;4367.323064924942;4367.563243675607;4381.627561657231;4387.956120438818;3894.337962546374;3908.7068469864307;3927.9607203928167;3958.129211573449;3958.802059896994;5141.71720555373;5162.819301324435;5200.141976573898;5243.711595862188;5352.143657014859;5543.805966791143;5552.91670624941;5585.385607583163;5595.972020139955;5597.244372009808;5230.34620672416;5232.241325007929;5242.292290540804;5262.158054711228;5315.255864179018;4695.600873925686;4786.664933454695;4809.422869255712;4840.636952228597;4923.655344125948;5836;5875.9118613220835;5899.764009439575;5916.615419997686;5928.555358348141;5548.306461692288;5640.60515763909;5649.63277386985;5656.406077361982;5677.233573467529;5780.913286300793;5815.82552523425;5840.94159058421;5864.589478736448;5880.558958078076;5483.890322193454;5492;5495.340559132929;5501.669899806025;5502;5506.724663766876;5516.420775818481;5563.944360556505;5595.048841697003;5605.243292155506;5532.889342213214;5542.75057622416;5592.217089607377;5617.494425501724;5650.63270887391;5423.105187643994;5430.049741295178;5436.945630543644;5438;5442.591805614516;5346.732663366738;5392.541633961;5401;5406.891862162656;5472.452754724496;5548.445155484419;5575.609707320448;5589.860253493533;5609.719514024364;5613.045782217115;5408.513233808976;5411.188321751769;5428.864278392914;5461.481159289861;5509.944900551103 16:34:01 INFO - PROCESS | 6833 | |1;ext.html;486.868545492717;512.7769420302171;543.798794446055;558.1850498272522;558.8100045984366;27570.310742231428;35527.467087993704;35556.64443355569;35710.82144589273;35744.2851142977;38121.80939095307;38908.80545597275;38921;38931.22137557247;39020.609793902055;8241.175882411771;8367.163283671614;8410.453320534176;8436.57817109145;8472.237498625123;8242.134575869537;8264.504129752204;8290.875636865421;8304.958475207615;8319;8302.377321700866;8316.37627177961;8339.498890199762;8362.749117526453;8364.58177091146;8285.295749861269;8290.08809031006;8292.419530632858;8431.072582015973;8504.064552899175;8376.623051962677;8440.029396619406;8498.277646400064;8512.106228846005;8528.6162122704;38045.23909521822;38794.418083728764;38795.22409551793;38960.22079558421;39104.21791564153;3104.5343198520177;3120.937581248385;3140.4661207594763;3153.4008538377634;3158.7946783459;29001;29007.70992290071;29093.41813163725;29781.851090744407;30333.848330758206;3773.962260377416;3828.655421012122;3829.100161462054;3840.385538313856;3907.5115610548683;198031;198518;199004;199624.00187999112;199657;50731.74634126806;51834.74082629563;54486;55055.72472137614;56981;52025.219621705706;52112;52130.739346303024;52133.478665213624;52202.73898630482;13853.584392468241;14060.648483787987;14126.152430853976;14213.857861421253;14220.431182752574;10156.39061656303;10236.846447303296;10247.538860751283;10283.897161028444;10285;18562.814371856108;18681.626367472574;18700.25198992052;18844;18903.24387024531;7708.190639982721;7910.683572657029;7983.802429635602;8030.718924837603;8075.273225409741;916.8028873792033;980.9068138526828;1017.9898201018043;1018.85735996959;1122.0630773304383;25270.620940685905;28291.71708282891;29811.552826707615;31007.84496077505;31150.26413324912;1000.9549570269355;1019.3119644240256;1030.6650338639972;1046.5186014433293;1123.269874581512;13233.338333083308;13375.799363009563;13435.19388836673;13526.93236533811;13704.24626645544;305770;309686;310560;310566;311310;48388.516114839105;48459.75770121127;48894.75552622214;48910.75544622254;48931.75534122306;1324.9403776829872;1336.2717319061135;1343.946242150303;1350.439567579463;1350.5948215535498;24851;25531.744682552937;25538.872305638353;25615.487690245718;25768;39252.803735981135;39395.40906886342;39465.60534394619;39511.20977580375;39710;239060;242552;243826.6851994443;292927;293759;30026.84986575053;31548.52677209798;32184.83907580447;32352.676473234966;32430.675693242767;37661.246775064894;38518.80740596279;39765.403518947816;40140.59859401369;40831;33586.49620255649;33635.327293453505;33954.83022584871;34059.318813624086;34514.654853451146;34484.82757586296;34625.30749385049;34665.133371665914;34995.825020874734;35049;35397.1150721234;35586.11034724153;35667.82166089153;36268.637313626525;36396.45405318975;27917.58123628188;27969.72030279671;29695.25761855971;30130.84934575313;30213.697863021087;23230.419239519146;23338.299851004496;23745.287641370785;23843.830117057936;24828.627570586093 16:34:01 INFO - PROCESS | 6833 | |2;jquery.html;360.3513675384309;362.47803163444644;362.9927401451971;363.3332834249153;364.1297299454303;15499.922500387496;16347.100909449975;16669.749953750703;17162.227699753526;17421.47735567932;10969.067629251504;11342.489587968541;16420.425285115023;16449.753253701176;16460.67078658426;4635.930461043087;5427.728613569326;5445.401005889349;5446.1558458439;5474.260974768415;5197.142471492218;5297.523222909937;5351.625386222966;5351.7324133793345;5429.945700543003;5161.9483805162035;5381.5425688816495;5394.8921021579545;5395.568354531648;5396.676199428027;5309.283246761676;5315.495027972317;5323.494268044529;5347.679139251619;5351.652142610737;5310.415854256029;5329.8934021319355;5360.0083984463;5376.650517716336;5380.139177731583;12394.876051239462;16789.496315110566;18030;18693.252269909186;18705.906470467697;1910.2168111074532;2064.95870082599;2069.4515953272394;2144.5179574688973;2193.056985496236;9513.429194248367;11007.724806879893;11212.495437705324;12623.558175463906;12995.220286782824;1826.3060037185917;1827.5248435406756;1828.7896891857474;1876.47458711561;1876.80293569176;54845.45154548444;55193;55279;57101.85796284093;57438.71280643612;10024.298299119138;10179.694609161737;10235.334703244265;10240.283180177315;10324.432156231329;13279.804817566466;13295.268760218281;13333.399997000159;13371.33143342829;13480.056396052181;7197.568145911157;7232.74685386009;7238.348548630648;7291.416686665054;7361.926380736124;6765.323467653294;6905.551139175937;6921.861562768717;6990.61551614666;6993.685284162225;4405.977970110193;4475;4490.797914093873;4496.348029535699;4497.550244975476;1794.6321004194108;1797.0412250646596;1838.5036040269054;1863.338514827244;1887.4054672778032;812.6226046850531;854.2909385210261;900.8245933085794;963.2486660404895;1063.2079101069753;15645.921770391304;15680.843191568167;15875.603109922113;15957.281922313523;16446.34214631425;854.0861278432018;904.1320332480892;908.3959167153901;932.7061975477703;967.5162418790604;5189.6886186828915;8776.473411595325;9019.864702029476;9128.726138215865;9797.516010477786;373039;383498;385496;551448;559360;58300.416995829495;61014.69492652508;61146.69426652927;61647;62353.688231559456;1034.2294990232174;1088.7659153282082;1091.7980173667897;1097.2209731090854;1103.779244151173;14440.133591984515;14525.92737036308;14730.926345368633;14779.187144707144;14860.925695371887;31402.52896206513;31518.842405787826;31822.36355272835;32172.13934327802;32624.184395390304;40275.79862100671;40698.59301406948;40701.778946631646;41012.58987410088;42511;2796.7902407319125;5516.0071187186695;7088.255733147946;7480.102387713509;7644.503107298008;10111.140553053074;10415.68752937413;11005;11064.225504214628;11270.94364528172;9388.389754665925;9648.179904708179;9669.468179250209;9780.804383912424;9873.25950553697;9577.185939195246;9839.803203936024;10002;10137.341072830242;10277.897221027693;8088.555129467935;10242.180625550087;10244.53899574506;10321.896781032094;10422.218333624856;7577.16651168382;7604;7850.960745196237;7891.881621775563;7935.880961785462;9389.765255868659;9977.501124943868;10084.69745907624;10197;10200.28597998133 16:34:02 INFO - PROCESS | 6833 | |3;mootools.html;1470.0665077675676;1485.9034162779421;1662.8170901200865;1773.8846974946619;1799.4511673939444;7543.924560754391;7597.962010189948;7751.922480775191;7807.804804879881;7815.452918295721;7843.960780196106;7853.214678532144;7869.80325491863;7945.602719863999;7956.045274567045;2298.5058212484355;2323.9883800581056;2330.3707998840305;2331.930042098731;2333.1367394064137;2326.906923723049;2359.268626725712;2364.9763502364926;2365.1367250953363;2376.4534157143867;2245.247841972941;2249.5388445368744;2257.695211146499;2264.071730590458;2326.8603883767028;2214.9114035438565;2251.538434620899;2273.056681477185;2273.533925545259;2274.920377786778;2244.450109723128;2270.4323919020244;2279.3959600705825;2284.5430913817136;2288.4736510602656;7350.154732205758;7377.004104445885;7406;7408.296211859864;7423.62881855905;4670.883227919295;4791.185498465269;4811.398575178103;4821.614270858323;4859.757012149414;3164.8259345735974;3186.3308705171944;3209.422303985282;3223.2425380035675;3226.951595726066;1016.7153197104749;1023.1303392116715;1030.2530665267695;1039.5270152080784;1084.7071290751453;10575.576976920915;10649.201309901711;10680.198985076073;10762.408067556282;10774.461276936201;4200.85297014603;4237.067845074079;4322.675799315064;4351.129774045204;4407.140607581491;9116.4074335168;9130.26957843371;9221.123993220634;9235.584398702074;9287.72136835896;4820.542048505386;4832.685875418087;4849.80600775965;4857.392825896763;4883.145449546315;4376.8905777355185;4390.209762242763;4435.1129774044675;4437.290033594674;4461.866144015685;3642.1987162824134;3649.50731651229;3651.233241019416;3686.2811751708696;3689.981550092286;1183.8342632031522;1187.5131196209513;1198.6044605280238;1210.7639010393066;1212.1878341511208;987.9901200988041;1000.0899181744578;1119.2165484160957;1135.8864113588575;1268.9936550317188;7341.3392794648735;7443.069616297963;7457.142428620669;7469.066366704162;7476.476646634792;1080.4165750494644;1090.0625462102585;1092.7213560542011;1117.6479408986143;1120.5909842907442;5756.107803290497;5773.278340207474;5785.913211301834;5787.768489260467;5839.766409343579;9024.8646270306;9219.400738951947;9479.052094790604;9483.430994140374;9602.855957160647;9278.164965153168;9287.396319239362;9302.906970930204;9303.023182565868;9506.857397139049;7234.312740289664;7316.707331706672;7348.485606007635;7359.374453171434;7364.999999999893;7046.718131274692;7078.716851326095;7086.397656199075;7088.362047415757;7101.928980710333;8062.1534738853925;8378.120297368689;8381.832363352576;8393.83212335762;8446.113158118555;8063.798405039921;8211.83576328482;8250.009998800182;8250.958745206475;8414.873776893473;7207.9639601801655;7410.851782964418;7444.106707194955;7477.887831682638;7487.064116985377;7467.551946883204;7497.512661676974;7506.136794268729;7511.661975211238;7513.248675132661;6965.895511567432;7090.929090709027;7211.567305961659;7262.9273707262255;7398.889016664647;6610.272869984202;6717.017676099515;6756.18925728896;7010.334018268256;7088.291170882871;6726.495512836655;6761.492888033319;6785.762498312535;6793.93206067933;6836.453083753388;6098.634081955097;6323.304436512072;6323.4625056868845;6346.4605508532295;6372.394622510854;6282.685865706788;6314;6336.334684858023;6370.426661600478;6401.167848179707 16:34:02 INFO - PROCESS | 6833 | |4;prototype.html;333.8080603652899;334.1945910356042;336.3122414662016;337.56285610134876;345.7683352154057;6294.811155665326;6337.873242535146;6342.14381058557;6346.6509341986175;6486.513511486633;6280.403361680645;6314.368563143684;6327;6351.872962540747;6365;4810.855674329776;4814.566688997989;4817.927731084036;4821.590164835993;4824.083424149418;4807.831725889595;4812.109759694467;4816.662833601649;4832.9275060874115;4833.564979151894;4678.994016286498;4761.190597598399;4770.260609605517;4782.473927867949;4782.97608511957;4763.761811909408;4767.856964291077;4771.9761401192945;4772.331873537708;4773.618110551182;4148.688848336356;4152.979235103835;4154.937675934863;4163.937540936889;4166.208420400114;6032.698365081728;6035.758569657209;6039.3960603939695;6041.214642096544;6041.758329666808;5399.5680345572655;5567.109262517978;5570.610057295991;5571.637843540157;5577.745007373349;6669.599824010526;6681.331866813329;6685.43173830225;6695.665216739192;6696.330366963313;4610.76946152691;4614.723116613014;4616.030633566921;4626.629869610423;4633.907321853544;6727.360900714424;6916.135483064617;6933.826654333631;7016.543924644881;7025.946108083726;4513.684042117086;4528.573499347761;4537.705049171794;4539.182947069559;4541.046380260183;4580.221362368406;4583.381243532147;4584.404027476407;4593.517680643551;4597.35637010812;5409.6213265071065;5415.512603865671;5421.457854214547;5429.077056900336;5432.375276843135;6570.474362051024;6714.865702685919;6723.630200339028;6727.394534491919;6734.764283250161;1624.84563966423;1644.8190699023098;1666.4084250091285;1666.5500314914905;1668.3243286468999;1069.411823497089;1073.3881687438086;1074.4412905289205;1086.8315411111291;1100.3178029621527;6236.376362363818;6281.089242059876;6286;6288.968555157195;6296.937030629635;6786.151731033621;6789.388954994074;6810.523263371616;6832.521723479408;6834.965825170842;6098.14625952367;6223.315435302113;6264.404881536247;6279.811605651837;6283.523372007575;3717.275131349415;3720.534933133358;3723.925521489555;3723.925521489555;3724.1620635356826;7111.7866464006165;7122.964385178145;7150.713971441188;7161.89257161143;7171.390431813355;6898.965505172442;6911.619860907698;6966.268541803139;6975.965120174468;6978.406835419046;7264.491485596063;7268.0914885639295;7271.054762880792;7310.488265821447;7350.3384695378745;7007.859842803217;7018.929810702032;7024.754133605299;7037.1555413350725;7062.293770622897;6831.521793474409;6904.516683832285;6908.274631163857;6961;6968.338007889242;7309.378702810321;7349.963250183715;7351.485396022227;7365.189829118685;7368.078990126234;4785.59322457595;4798.184308667465;4811.4707382188635;4816.181249187576;4816.54242846943;6848.1097457330225;6986.895196572157;6992.370686638227;6995.090638217;6997.160340758938;6777.1189745332795;6788.389044985975;6790.72837086511;6846.760363387258;6867.725290988505;6723.159605049369;6733.293004234485;6750.628715420699;6760.121184246016;6769.966150169218;6432.678366081584;6552.27924928267;6619.602823830585;6624.436922861611;6632.867342653217;6767.187937447341;6775.288594697683;6777.491688123509;6785.796426107225;6803.965980170067;6523.510736694672;6554.14796076507;6564.179477565304;6569.638669873203;6569.770058047945 16:34:02 INFO - PROCESS | 6833 | |5;yui.html;820.7701843483823;822.087482893988;824.9298809601183;838.9932081502195;845.188618925831;13426.597202083942;13522.256275904821;13571.05002649815;13597.932010339946;13625.727485450298;12733.490660373596;12822.358882055883;12823.935880320609;13339.933300333509;13783.931080344584;798.48896706108;814.633414963266;816.6692489541745;820.3806126374578;821.2239433735123;793.5199204481293;802.173761026141;808.3008197908796;808.308895894011;808.8180159464132;856.8029353248756;857.3312816003527;858.9012263589674;859.879616853641;860.5826174305457;853.9487630742144;854.7692123126752;856.0583358305876;857.4169564696004;860.2730692564835;623.1151764494429;624.9843753906143;625.671522450717;628.7045088808253;631.4727202785633;12570.497180112785;12601.74796504074;12624.81062784059;12657.683557911127;12684.619461416172;12671.36643167838;12687.238765674088;12941.935290323489;12960.48158073676;13042.608721738363;10229.948850255701;10499.160067194682;10553.577856885715;10610.787784244349;10668.679939601825;3496.8950931472095;3583.050491619723;3587.964120358789;3633.255182687543;3654.451832225161;44475.332870006976;44674;47368.28947565789;52695;54218.99999999961;7991.320737737241;8726.694565690297;9466.621335146518;9519.286053546011;9578.377405468622;17410.47768566945;17527.123643818013;17566.03386813712;17606;17646.735298970525;6997.291435539172;7154.034205382311;7167.247439018932;7174.892376614355;7408;4307.8492252771;4401.867943961686;4408.9859332353735;4492.573205545468;4542.613877820356;2975.0777259049764;2978.5234362501897;2981.4335276297434;2988.1035689293126;2997.430488207234;553.7840242305504;567.6026781253139;568.8407245971134;569.6041251330369;584.6316820403118;476.5782282679853;495.5861855350822;551.3053552523769;564.5177292299131;583.2650859916536;7798.805029874298;7895.407844411692;7929.881051784228;8040.155783642634;8332.875006874901;509.6559822120054;581.979630712923;632.2665707778955;632.8164832198703;670.6780745242213;3724.981375093107;3777.150141218259;3819.3698039823676;3862.169633528749;3900.8244628991765;53860.46139538633;55363.16955245675;55417.722911385186;55751;55967.72016139893;46661;47394.54962679267;47751.283730744064;47890.28164577534;47916.520834791205;44232.557674423486;44306;44483.332750008776;46092.07815843664;46173.53826461759;7807.687692492464;7981;8153.673853046049;8287.83424331498;8344.916550834414;32153.517697234092;33402.33195336128;34164.82917585495;34287.82856085704;34398.14004649904;43251.13497729965;44104;45930;47113.764431177624;47580.76209619068;10129.797404051731;10866.554407500722;10904.61833835812;11038.227324087558;11239.213255072067;11938.58214962472;11982.64052078439;12124.33316167584;12330.506779729069;12570.245785252548;11019.118470522179;11368.488418021043;11582.88417115818;11808.94095529517;11855.043917753474;10304.793904122025;10362.288293202886;10366.274360794672;10427.524511272324;10662.253642244968;11235.943820280847;11271.605493807678;11590.826137607773;11654;11670.358130302915;8840;8942.195202431813;8979.685711000084;9320.860187097063;9439.244860411289;7773.339266162213;8088.555129467935;8112.959435202786;8578.4424012439;8613.870791938001 16:34:02 INFO - PROCESS | 6833 | __end_tp_report 16:34:02 INFO - PROCESS | 6833 | __start_cc_report 16:34:02 INFO - PROCESS | 6833 | _x_x_mozilla_cycle_collect,324 16:34:02 INFO - PROCESS | 6833 | __end_cc_report 16:34:02 INFO - PROCESS | 6833 | __startTimestamp1453422841991__endTimestamp 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | ------- Summary: start ------- 16:34:02 INFO - PROCESS | 6833 | Number of tests: 6 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#0] dojo.html Cycles:165 Average:5218.48 Median:5428.86 stddev:560.75 (10.3%) stddev-sans-first:537.80 16:34:02 INFO - PROCESS | 6833 | Values: 3121.2 3204.7 3226.5 3241.7 3254.1 5163.4 5211.8 5224.3 5225.6 5271.7 5173.7 5187.3 5218.2 5243.7 5253.6 4749.9 4759.3 4802.7 4809.8 4898.5 4461.1 4797.9 4805.6 4854.7 4862.2 4737.8 4763.4 4804.8 4825.1 4841.2 4779.1 4815.3 4816.0 4820.1 4822.8 4676.2 4771.0 4787.9 4801.5 4828.1 5076.2 5162.3 5193.8 5207.4 5230.8 5523.8 5528.4 5538.6 5540.8 5550.4 5472.4 5554.6 5587.5 5603.5 5662.7 5297.8 5317.0 5327.4 5329.0 5383.9 5753.9 5784.8 5797.7 5803.9 5812.6 5517.4 5528.4 5582.2 5582.8 5593.7 5547.7 5555.9 5565.5 5571.6 5584.2 5487.0 5528.4 5537.0 5538.1 5540.8 5473.7 5475.9 5519.6 5586.9 5600.8 4353.6 4367.3 4367.6 4381.6 4388.0 3894.3 3908.7 3928.0 3958.1 3958.8 5141.7 5162.8 5200.1 5243.7 5352.1 5543.8 5552.9 5585.4 5596.0 5597.2 5230.3 5232.2 5242.3 5262.2 5315.3 4695.6 4786.7 4809.4 4840.6 4923.7 5836.0 5875.9 5899.8 5916.6 5928.6 5548.3 5640.6 5649.6 5656.4 5677.2 5780.9 5815.8 5840.9 5864.6 5880.6 5483.9 5492.0 5495.3 5501.7 5502.0 5506.7 5516.4 5563.9 5595.0 5605.2 5532.9 5542.8 5592.2 5617.5 5650.6 5423.1 5430.0 5436.9 5438.0 5442.6 5346.7 5392.5 5401.0 5406.9 5472.5 5548.4 5575.6 5589.9 5609.7 5613.0 5408.5 5411.2 5428.9 5461.5 5509.9 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#1] ext.html Cycles:180 Average:41847.49 Median:34645.22 stddev:68276.22 (197.1%) stddev-sans-first:68397.13 16:34:02 INFO - PROCESS | 6833 | Values: 486.9 512.8 543.8 558.2 558.8 27570.3 35527.5 35556.6 35710.8 35744.3 38121.8 38908.8 38921.0 38931.2 39020.6 8241.2 8367.2 8410.5 8436.6 8472.2 8242.1 8264.5 8290.9 8305.0 8319.0 8302.4 8316.4 8339.5 8362.7 8364.6 8285.3 8290.1 8292.4 8431.1 8504.1 8376.6 8440.0 8498.3 8512.1 8528.6 38045.2 38794.4 38795.2 38960.2 39104.2 3104.5 3120.9 3140.5 3153.4 3158.8 29001.0 29007.7 29093.4 29781.9 30333.8 3774.0 3828.7 3829.1 3840.4 3907.5 198031.0 198518.0 199004.0 199624.0 199657.0 50731.7 51834.7 54486.0 55055.7 56981.0 52025.2 52112.0 52130.7 52133.5 52202.7 13853.6 14060.6 14126.2 14213.9 14220.4 10156.4 10236.8 10247.5 10283.9 10285.0 18562.8 18681.6 18700.3 18844.0 18903.2 7708.2 7910.7 7983.8 8030.7 8075.3 916.8 980.9 1018.0 1018.9 1122.1 25270.6 28291.7 29811.6 31007.8 31150.3 1001.0 1019.3 1030.7 1046.5 1123.3 13233.3 13375.8 13435.2 13526.9 13704.2 305770.0 309686.0 310560.0 310566.0 311310.0 48388.5 48459.8 48894.8 48910.8 48931.8 1324.9 1336.3 1343.9 1350.4 1350.6 24851.0 25531.7 25538.9 25615.5 25768.0 39252.8 39395.4 39465.6 39511.2 39710.0 239060.0 242552.0 243826.7 292927.0 293759.0 30026.8 31548.5 32184.8 32352.7 32430.7 37661.2 38518.8 39765.4 40140.6 40831.0 33586.5 33635.3 33954.8 34059.3 34514.7 34484.8 34625.3 34665.1 34995.8 35049.0 35397.1 35586.1 35667.8 36268.6 36396.5 27917.6 27969.7 29695.3 30130.8 30213.7 23230.4 23338.3 23745.3 23843.8 24828.6 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#2] jquery.html Cycles:180 Average:24463.84 Median:40700.19 stddev:74927.71 (184.1%) stddev-sans-first:75116.04 16:34:02 INFO - PROCESS | 6833 | Values: 360.4 362.5 363.0 363.3 364.1 15499.9 16347.1 16669.7 17162.2 17421.5 10969.1 11342.5 16420.4 16449.8 16460.7 4635.9 5427.7 5445.4 5446.2 5474.3 5197.1 5297.5 5351.6 5351.7 5429.9 5161.9 5381.5 5394.9 5395.6 5396.7 5309.3 5315.5 5323.5 5347.7 5351.7 5310.4 5329.9 5360.0 5376.7 5380.1 12394.9 16789.5 18030.0 18693.3 18705.9 1910.2 2065.0 2069.5 2144.5 2193.1 9513.4 11007.7 11212.5 12623.6 12995.2 1826.3 1827.5 1828.8 1876.5 1876.8 54845.5 55193.0 55279.0 57101.9 57438.7 10024.3 10179.7 10235.3 10240.3 10324.4 13279.8 13295.3 13333.4 13371.3 13480.1 7197.6 7232.7 7238.3 7291.4 7361.9 6765.3 6905.6 6921.9 6990.6 6993.7 4406.0 4475.0 4490.8 4496.3 4497.6 1794.6 1797.0 1838.5 1863.3 1887.4 812.6 854.3 900.8 963.2 1063.2 15645.9 15680.8 15875.6 15957.3 16446.3 854.1 904.1 908.4 932.7 967.5 5189.7 8776.5 9019.9 9128.7 9797.5 373039.0 383498.0 385496.0 551448.0 559360.0 58300.4 61014.7 61146.7 61647.0 62353.7 1034.2 1088.8 1091.8 1097.2 1103.8 14440.1 14525.9 14730.9 14779.2 14860.9 31402.5 31518.8 31822.4 32172.1 32624.2 40275.8 40698.6 40701.8 41012.6 42511.0 2796.8 5516.0 7088.3 7480.1 7644.5 10111.1 10415.7 11005.0 11064.2 11270.9 9388.4 9648.2 9669.5 9780.8 9873.3 9577.2 9839.8 10002.0 10137.3 10277.9 8088.6 10242.2 10244.5 10321.9 10422.2 7577.2 7604.0 7851.0 7891.9 7935.9 9389.8 9977.5 10084.7 10197.0 10200.3 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#3] mootools.html Cycles:180 Average:5469.67 Median:6298.34 stddev:2799.26 (44.4%) stddev-sans-first:2790.97 16:34:02 INFO - PROCESS | 6833 | Values: 1470.1 1485.9 1662.8 1773.9 1799.5 7543.9 7598.0 7751.9 7807.8 7815.5 7844.0 7853.2 7869.8 7945.6 7956.0 2298.5 2324.0 2330.4 2331.9 2333.1 2326.9 2359.3 2365.0 2365.1 2376.5 2245.2 2249.5 2257.7 2264.1 2326.9 2214.9 2251.5 2273.1 2273.5 2274.9 2244.5 2270.4 2279.4 2284.5 2288.5 7350.2 7377.0 7406.0 7408.3 7423.6 4670.9 4791.2 4811.4 4821.6 4859.8 3164.8 3186.3 3209.4 3223.2 3227.0 1016.7 1023.1 1030.3 1039.5 1084.7 10575.6 10649.2 10680.2 10762.4 10774.5 4200.9 4237.1 4322.7 4351.1 4407.1 9116.4 9130.3 9221.1 9235.6 9287.7 4820.5 4832.7 4849.8 4857.4 4883.1 4376.9 4390.2 4435.1 4437.3 4461.9 3642.2 3649.5 3651.2 3686.3 3690.0 1183.8 1187.5 1198.6 1210.8 1212.2 988.0 1000.1 1119.2 1135.9 1269.0 7341.3 7443.1 7457.1 7469.1 7476.5 1080.4 1090.1 1092.7 1117.6 1120.6 5756.1 5773.3 5785.9 5787.8 5839.8 9024.9 9219.4 9479.1 9483.4 9602.9 9278.2 9287.4 9302.9 9303.0 9506.9 7234.3 7316.7 7348.5 7359.4 7365.0 7046.7 7078.7 7086.4 7088.4 7101.9 8062.2 8378.1 8381.8 8393.8 8446.1 8063.8 8211.8 8250.0 8251.0 8414.9 7208.0 7410.9 7444.1 7477.9 7487.1 7467.6 7497.5 7506.1 7511.7 7513.2 6965.9 7090.9 7211.6 7262.9 7398.9 6610.3 6717.0 6756.2 7010.3 7088.3 6726.5 6761.5 6785.8 6793.9 6836.5 6098.6 6323.3 6323.5 6346.5 6372.4 6282.7 6314.0 6336.3 6370.4 6401.2 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#4] prototype.html Cycles:180 Average:5585.63 Median:6295.87 stddev:1715.07 (27.2%) stddev-sans-first:1673.97 16:34:02 INFO - PROCESS | 6833 | Values: 333.8 334.2 336.3 337.6 345.8 6294.8 6337.9 6342.1 6346.7 6486.5 6280.4 6314.4 6327.0 6351.9 6365.0 4810.9 4814.6 4817.9 4821.6 4824.1 4807.8 4812.1 4816.7 4832.9 4833.6 4679.0 4761.2 4770.3 4782.5 4783.0 4763.8 4767.9 4772.0 4772.3 4773.6 4148.7 4153.0 4154.9 4163.9 4166.2 6032.7 6035.8 6039.4 6041.2 6041.8 5399.6 5567.1 5570.6 5571.6 5577.7 6669.6 6681.3 6685.4 6695.7 6696.3 4610.8 4614.7 4616.0 4626.6 4633.9 6727.4 6916.1 6933.8 7016.5 7025.9 4513.7 4528.6 4537.7 4539.2 4541.0 4580.2 4583.4 4584.4 4593.5 4597.4 5409.6 5415.5 5421.5 5429.1 5432.4 6570.5 6714.9 6723.6 6727.4 6734.8 1624.8 1644.8 1666.4 1666.6 1668.3 1069.4 1073.4 1074.4 1086.8 1100.3 6236.4 6281.1 6286.0 6289.0 6296.9 6786.2 6789.4 6810.5 6832.5 6835.0 6098.1 6223.3 6264.4 6279.8 6283.5 3717.3 3720.5 3723.9 3723.9 3724.2 7111.8 7123.0 7150.7 7161.9 7171.4 6899.0 6911.6 6966.3 6976.0 6978.4 7264.5 7268.1 7271.1 7310.5 7350.3 7007.9 7018.9 7024.8 7037.2 7062.3 6831.5 6904.5 6908.3 6961.0 6968.3 7309.4 7350.0 7351.5 7365.2 7368.1 4785.6 4798.2 4811.5 4816.2 4816.5 6848.1 6986.9 6992.4 6995.1 6997.2 6777.1 6788.4 6790.7 6846.8 6867.7 6723.2 6733.3 6750.6 6760.1 6770.0 6432.7 6552.3 6619.6 6624.4 6632.9 6767.2 6775.3 6777.5 6785.8 6804.0 6523.5 6554.1 6564.2 6569.6 6569.8 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - PROCESS | 6833 | [#5] yui.html Cycles:180 Average:13430.28 Median:46887.38 stddev:15561.80 (33.2%) stddev-sans-first:15576.64 16:34:02 INFO - PROCESS | 6833 | Values: 820.8 822.1 824.9 839.0 845.2 13426.6 13522.3 13571.1 13597.9 13625.7 12733.5 12822.4 12823.9 13339.9 13783.9 798.5 814.6 816.7 820.4 821.2 793.5 802.2 808.3 808.3 808.8 856.8 857.3 858.9 859.9 860.6 853.9 854.8 856.1 857.4 860.3 623.1 625.0 625.7 628.7 631.5 12570.5 12601.7 12624.8 12657.7 12684.6 12671.4 12687.2 12941.9 12960.5 13042.6 10229.9 10499.2 10553.6 10610.8 10668.7 3496.9 3583.1 3588.0 3633.3 3654.5 44475.3 44674.0 47368.3 52695.0 54219.0 7991.3 8726.7 9466.6 9519.3 9578.4 17410.5 17527.1 17566.0 17606.0 17646.7 6997.3 7154.0 7167.2 7174.9 7408.0 4307.8 4401.9 4409.0 4492.6 4542.6 2975.1 2978.5 2981.4 2988.1 2997.4 553.8 567.6 568.8 569.6 584.6 476.6 495.6 551.3 564.5 583.3 7798.8 7895.4 7929.9 8040.2 8332.9 509.7 582.0 632.3 632.8 670.7 3725.0 3777.2 3819.4 3862.2 3900.8 53860.5 55363.2 55417.7 55751.0 55967.7 46661.0 47394.5 47751.3 47890.3 47916.5 44232.6 44306.0 44483.3 46092.1 46173.5 7807.7 7981.0 8153.7 8287.8 8344.9 32153.5 33402.3 34164.8 34287.8 34398.1 43251.1 44104.0 45930.0 47113.8 47580.8 10129.8 10866.6 10904.6 11038.2 11239.2 11938.6 11982.6 12124.3 12330.5 12570.2 11019.1 11368.5 11582.9 11808.9 11855.0 10304.8 10362.3 10366.3 10427.5 10662.3 11235.9 11271.6 11590.8 11654.0 11670.4 8840.0 8942.2 8979.7 9320.9 9439.2 7773.3 8088.6 8113.0 8578.4 8613.9 16:34:02 INFO - PROCESS | 6833 | -------- Summary: end -------- 16:34:02 INFO - PROCESS | 6833 | 16:34:02 INFO - TEST-INFO | 6833: exit 0 16:34:02 INFO - TEST-OK | dromaeo_css | took 1110908ms 16:34:02 INFO - TEST-START | kraken 16:34:02 INFO - operating with platform_type : linux_ 16:34:02 INFO - Initialising browser for kraken test... 16:34:02 INFO - TEST-INFO | started process 7077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIxNIr3/profile http://localhost:32786/getInfo.html) 16:34:06 INFO - PROCESS | 7077 | 16:34:06 INFO - PROCESS | 7077 | (process:7148): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:34:07 INFO - PROCESS | 7077 | __metrics Screen width/height:1600/1200 16:34:07 INFO - PROCESS | 7077 | colorDepth:24 16:34:07 INFO - PROCESS | 7077 | Browser inner width/height: 1024/697 16:34:07 INFO - PROCESS | 7077 | __metrics 16:34:07 INFO - PROCESS | 7077 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:34:08 INFO - TEST-INFO | 7077: exit 0 16:34:08 INFO - Browser initialized. 16:34:08 INFO - Running cycle 1/1 for kraken test... 16:34:08 INFO - TEST-INFO | started process 7197 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIxNIr3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:09 INFO - PROCESS | 7197 | 16:34:09 INFO - PROCESS | 7197 | (process:7254): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:34:20 INFO - PROCESS | 7197 | RSS: Main: 153411584 16:34:20 INFO - PROCESS | 7197 | 16:34:22 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:23 INFO - PROCESS | 7197 | RSS: Main: 157970432 16:34:23 INFO - PROCESS | 7197 | 16:34:26 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-dft) 16:34:26 INFO - PROCESS | 7197 | RSS: Main: 160555008 16:34:26 INFO - PROCESS | 7197 | 16:34:29 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-fft) 16:34:30 INFO - PROCESS | 7197 | RSS: Main: 155222016 16:34:30 INFO - PROCESS | 7197 | 16:34:32 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32786/tests/kraken/driver.html?testName=audio-oscillator) 16:34:33 INFO - PROCESS | 7197 | RSS: Main: 154873856 16:34:33 INFO - PROCESS | 7197 | 16:34:35 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:35 INFO - PROCESS | 7197 | RSS: Main: 154566656 16:34:35 INFO - PROCESS | 7197 | 16:34:38 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:39 INFO - PROCESS | 7197 | RSS: Main: 154976256 16:34:39 INFO - PROCESS | 7197 | 16:34:42 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32786/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:43 INFO - PROCESS | 7197 | RSS: Main: 155320320 16:34:43 INFO - PROCESS | 7197 | 16:34:46 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32786/tests/kraken/driver.html?testName=json-parse-financial) 16:34:46 INFO - PROCESS | 7197 | RSS: Main: 155844608 16:34:46 INFO - PROCESS | 7197 | 16:34:48 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:48 INFO - PROCESS | 7197 | RSS: Main: 156667904 16:34:48 INFO - PROCESS | 7197 | 16:34:50 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:51 INFO - PROCESS | 7197 | RSS: Main: 155394048 16:34:51 INFO - PROCESS | 7197 | 16:34:53 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:54 INFO - PROCESS | 7197 | RSS: Main: 156368896 16:34:54 INFO - PROCESS | 7197 | 16:34:56 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:57 INFO - PROCESS | 7197 | RSS: Main: 155492352 16:34:57 INFO - PROCESS | 7197 | 16:34:59 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:00 INFO - PROCESS | 7197 | RSS: Main: 156946432 16:35:00 INFO - PROCESS | 7197 | 16:35:01 INFO - PROCESS | 7197 | Cycle 1(1): loaded http://localhost:32786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32786/tests/kraken/driver.html?testName=ai-astar) 16:35:02 INFO - PROCESS | 7197 | RSS: Main: 156712960 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | __start_tp_report 16:35:02 INFO - PROCESS | 7197 | _x_x_mozilla_page_load 16:35:02 INFO - PROCESS | 7197 | _x_x_mozilla_page_load_details 16:35:02 INFO - PROCESS | 7197 | |i|pagename|runs| 16:35:02 INFO - PROCESS | 7197 | |0;ai-astar;113;108;111;111;111;124;109;110;110;111 16:35:02 INFO - PROCESS | 7197 | |1;audio-beat-detection;155;129;153;169;128;160;152;139;170;127 16:35:02 INFO - PROCESS | 7197 | |2;audio-dft;165;162;162;164;163;163;163;163;170;163 16:35:02 INFO - PROCESS | 7197 | |3;audio-fft;73;73;72;75;73;159;76;72;72;74 16:35:02 INFO - PROCESS | 7197 | |4;audio-oscillator;95;96;145;96;97;96;143;96;101;142 16:35:02 INFO - PROCESS | 7197 | |5;imaging-gaussian-blur;113;109;111;110;109;110;110;109;110;110 16:35:02 INFO - PROCESS | 7197 | |6;imaging-darkroom;149;147;148;147;147;147;147;147;148;148 16:35:02 INFO - PROCESS | 7197 | |7;imaging-desaturate;98;97;97;96;97;96;97;97;97;96 16:35:02 INFO - PROCESS | 7197 | |8;json-parse-financial;61;60;62;60;61;61;61;61;61;59 16:35:02 INFO - PROCESS | 7197 | |9;json-stringify-tinderbox;71;68;68;68;69;69;67;68;68;69 16:35:02 INFO - PROCESS | 7197 | |10;stanford-crypto-aes;90;87;91;82;85;85;84;84;84;90 16:35:02 INFO - PROCESS | 7197 | |11;stanford-crypto-ccm;123;133;114;122;119;114;115;132;132;121 16:35:02 INFO - PROCESS | 7197 | |12;stanford-crypto-pbkdf2;137;145;145;153;136;133;152;134;151;145 16:35:02 INFO - PROCESS | 7197 | |13;stanford-crypto-sha256-iterative;68;68;69;70;68;68;67;70;69;67 16:35:02 INFO - PROCESS | 7197 | __end_tp_report 16:35:02 INFO - PROCESS | 7197 | __start_cc_report 16:35:02 INFO - PROCESS | 7197 | _x_x_mozilla_cycle_collect,727 16:35:02 INFO - PROCESS | 7197 | __end_cc_report 16:35:02 INFO - PROCESS | 7197 | __startTimestamp1453422902192__endTimestamp 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | ------- Summary: start ------- 16:35:02 INFO - PROCESS | 7197 | Number of tests: 14 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.49 (4.0%) stddev-sans-first:4.74 16:35:02 INFO - PROCESS | 7197 | Values: 113.0 108.0 111.0 111.0 111.0 124.0 109.0 110.0 110.0 111.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.00 stddev:16.47 (10.7%) stddev-sans-first:17.29 16:35:02 INFO - PROCESS | 7197 | Values: 155.0 129.0 153.0 169.0 128.0 160.0 152.0 139.0 170.0 127.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.35 (1.4%) stddev-sans-first:2.45 16:35:02 INFO - PROCESS | 7197 | Values: 165.0 162.0 162.0 164.0 163.0 163.0 163.0 163.0 170.0 163.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#3] audio-fft Cycles:10 Average:81.90 Median:73.00 stddev:27.12 (37.2%) stddev-sans-first:28.58 16:35:02 INFO - PROCESS | 7197 | Values: 73.0 73.0 72.0 75.0 73.0 159.0 76.0 72.0 72.0 74.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:22.59 (23.5%) stddev-sans-first:23.23 16:35:02 INFO - PROCESS | 7197 | Values: 95.0 96.0 145.0 96.0 97.0 96.0 143.0 96.0 101.0 142.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:0.67 16:35:02 INFO - PROCESS | 7197 | Values: 113.0 109.0 111.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 16:35:02 INFO - PROCESS | 7197 | Values: 149.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 16:35:02 INFO - PROCESS | 7197 | Values: 98.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 97.0 96.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 16:35:02 INFO - PROCESS | 7197 | Values: 61.0 60.0 62.0 60.0 61.0 61.0 61.0 61.0 61.0 59.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:1.08 (1.6%) stddev-sans-first:0.67 16:35:02 INFO - PROCESS | 7197 | Values: 71.0 68.0 68.0 68.0 69.0 69.0 67.0 68.0 68.0 69.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:3.12 (3.6%) stddev-sans-first:2.99 16:35:02 INFO - PROCESS | 7197 | Values: 90.0 87.0 91.0 82.0 85.0 85.0 84.0 84.0 84.0 90.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:122.50 stddev:7.50 (6.1%) stddev-sans-first:7.95 16:35:02 INFO - PROCESS | 7197 | Values: 123.0 133.0 114.0 122.0 119.0 114.0 115.0 132.0 132.0 121.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:145.00 stddev:7.62 (5.3%) stddev-sans-first:7.76 16:35:02 INFO - PROCESS | 7197 | Values: 137.0 145.0 145.0 153.0 136.0 133.0 152.0 134.0 151.0 145.0 16:35:02 INFO - PROCESS | 7197 | 16:35:02 INFO - PROCESS | 7197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 16:35:02 INFO - PROCESS | 7197 | Values: 68.0 68.0 69.0 70.0 68.0 68.0 67.0 70.0 69.0 67.0 16:35:02 INFO - PROCESS | 7197 | -------- Summary: end -------- 16:35:02 INFO - PROCESS | 7197 | 16:35:03 INFO - TEST-INFO | 7197: exit 0 16:35:03 INFO - TEST-OK | kraken | took 60476ms 16:35:03 INFO - TEST-START | v8_7 16:35:03 INFO - operating with platform_type : linux_ 16:35:03 INFO - Initialising browser for v8_7 test... 16:35:03 INFO - TEST-INFO | started process 7483 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA5nI3J/profile http://localhost:32786/getInfo.html) 16:35:06 INFO - PROCESS | 7483 | 16:35:06 INFO - PROCESS | 7483 | (process:7555): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:35:07 INFO - PROCESS | 7483 | __metrics Screen width/height:1600/1200 16:35:07 INFO - PROCESS | 7483 | colorDepth:24 16:35:07 INFO - PROCESS | 7483 | Browser inner width/height: 1024/697 16:35:07 INFO - PROCESS | 7483 | __metrics 16:35:08 INFO - PROCESS | 7483 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:35:08 INFO - TEST-INFO | 7483: exit 0 16:35:08 INFO - Browser initialized. 16:35:08 INFO - Running cycle 1/1 for v8_7 test... 16:35:08 INFO - TEST-INFO | started process 7604 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA5nI3J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:10 INFO - PROCESS | 7604 | 16:35:10 INFO - PROCESS | 7604 | (process:7662): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:35:20 INFO - PROCESS | 7604 | RSS: Main: 151945216 16:35:20 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | Cycle 1(1): loaded http://localhost:32786/tests/v8_7/run.html (next: http://localhost:32786/tests/v8_7/run.html) 16:35:43 INFO - PROCESS | 7604 | RSS: Main: 152723456 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | __start_tp_report 16:35:43 INFO - PROCESS | 7604 | _x_x_mozilla_page_load 16:35:43 INFO - PROCESS | 7604 | _x_x_mozilla_page_load_details 16:35:43 INFO - PROCESS | 7604 | |i|pagename|runs| 16:35:43 INFO - PROCESS | 7604 | |0;Richards;166.19577862722286 16:35:43 INFO - PROCESS | 7604 | |1;DeltaBlue;188.78610534264678 16:35:43 INFO - PROCESS | 7604 | |2;Encrypt;280.97780275358247 16:35:43 INFO - PROCESS | 7604 | |3;Decrypt;5218.75 16:35:43 INFO - PROCESS | 7604 | |4;RayTrace;1075.268817204301 16:35:43 INFO - PROCESS | 7604 | |5;Earley;693.000693000693 16:35:43 INFO - PROCESS | 7604 | |6;Boyer;12370.37037037037 16:35:43 INFO - PROCESS | 7604 | |7;RegExp;41020 16:35:43 INFO - PROCESS | 7604 | |8;Splay;599.5203836930456 16:35:43 INFO - PROCESS | 7604 | |9;NavierStokes;4830.917874396136 16:35:43 INFO - PROCESS | 7604 | __end_tp_report 16:35:43 INFO - PROCESS | 7604 | __startTimestamp1453422943385__endTimestamp 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | ------- Summary: start ------- 16:35:43 INFO - PROCESS | 7604 | Number of tests: 10 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 166.2 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 188.8 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 281.0 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 5218.8 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 1075.3 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#5] Earley Cycles:1 Average:693.00 Median:693.00 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 693.0 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 12370.4 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#7] RegExp Cycles:1 Average:41020.00 Median:41020.00 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 41020.0 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 599.5 16:35:43 INFO - PROCESS | 7604 | 16:35:43 INFO - PROCESS | 7604 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 16:35:43 INFO - PROCESS | 7604 | Values: 4830.9 16:35:43 INFO - PROCESS | 7604 | -------- Summary: end -------- 16:35:43 INFO - PROCESS | 7604 | 16:35:44 INFO - TEST-INFO | 7604: exit 0 16:35:44 INFO - TEST-OK | v8_7 | took 41133ms 16:35:44 INFO - SUITE-END | took 1212s 16:35:44 INFO - Completed test suite (00:20:12) 16:35:44 INFO - Working with test: dromaeo_css 16:35:44 INFO - Generating results file: dromaeo_css 16:35:44 INFO - Working with test: kraken 16:35:44 INFO - Generating results file: kraken 16:35:44 INFO - javascript benchmark 16:35:44 INFO - Working with test: v8_7 16:35:44 INFO - Generating results file: v8_7 16:35:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:35:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:35:44 INFO - process_Request line: dromaeo_css 6804.30 graph.html#tests=[[72,63,43]] 16:35:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:35:44 INFO - process_Request line: kraken 1520.20 graph.html#tests=[[232,63,43]] 16:35:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:35:44 INFO - process_Request line: v8_7 20411.50 graph.html#tests=[[230,63,43]] 16:35:44 INFO - RETURN: dromaeo_css: 6804.30 16:35:44 INFO - RETURN: kraken: 1520.20 16:35:44 INFO - RETURN: v8_7: 20411.50 16:35:44 INFO - javascript benchmark 16:35:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.235297352149, 3204.7115759581634, 3226.4515032444483, 3241.6920392562706, 3254.1213872254493, 5163.432022477534, 5211.843644690656, 5224.320838291022, 5225.581953443725, 5271.710055946922, 5173.663711858727, 5187.299714538536, 5218.1650935850275, 5243.711595862226, 5253.57971362291, 4749.90500189996, 4759.262314341283, 4802.687825291362, 4809.7835597398025, 4898.485659005806, 4461.130079634472, 4797.856064318076, 4805.591524720386, 4854.732989685566, 4862.246351815475, 4737.81048758051, 4763.3807605011125, 4804.783784729696, 4825.131476334259, 4841.225403935354, 4779.068081724065, 4815.253635686474, 4816.012717392926, 4820.132376172288, 4822.7829747661435, 4676.205045142334, 4771.045790841811, 4787.880302992418, 4801.519848015206, 4828.106800241966, 5076.162433198518, 5162.277281180638, 5193.766280517386, 5207.375114986188, 5230.764615592308, 5523.751431185607, 5528.391876893538, 5538.556915446755, 5540.806071787509, 5550.361708403545, 5472.370677372113, 5554.583406244547, 5587.469190426903, 5603.523700485463, 5662.716864156817, 5297.761600727977, 5317.016351974897, 5327.4139844616675, 5329.0, 5383.919241211385, 5753.942460575341, 5784.797532086357, 5797.681127538026, 5803.9419605803405, 5812.593118481665, 5517.393086760453, 5528.364238112668, 5582.162675598612, 5582.804601838916, 5593.720313984284, 5547.667139971534, 5555.861103472445, 5565.471280228372, 5571.609987300931, 5584.21820945068, 5487.039768040657, 5528.44715528444, 5536.972315138399, 5538.141588053858, 5540.7783688652, 5473.698946557977, 5475.890482190334, 5519.613627046068, 5586.86032849182, 5600.803971860965, 4353.564643535621, 4367.323064924942, 4367.563243675607, 4381.627561657231, 4387.956120438818, 3894.337962546374, 3908.7068469864307, 3927.9607203928167, 3958.129211573449, 3958.802059896994, 5141.71720555373, 5162.819301324435, 5200.141976573898, 5243.711595862188, 5352.143657014859, 5543.805966791143, 5552.91670624941, 5585.385607583163, 5595.972020139955, 5597.244372009808, 5230.34620672416, 5232.241325007929, 5242.292290540804, 5262.158054711228, 5315.255864179018, 4695.600873925686, 4786.664933454695, 4809.422869255712, 4840.636952228597, 4923.655344125948, 5836.0, 5875.9118613220835, 5899.764009439575, 5916.615419997686, 5928.555358348141, 5548.306461692288, 5640.60515763909, 5649.63277386985, 5656.406077361982, 5677.233573467529, 5780.913286300793, 5815.82552523425, 5840.94159058421, 5864.589478736448, 5880.558958078076, 5483.890322193454, 5492.0, 5495.340559132929, 5501.669899806025, 5502.0, 5506.724663766876, 5516.420775818481, 5563.944360556505, 5595.048841697003, 5605.243292155506, 5532.889342213214, 5542.75057622416, 5592.217089607377, 5617.494425501724, 5650.63270887391, 5423.105187643994, 5430.049741295178, 5436.945630543644, 5438.0, 5442.591805614516, 5346.732663366738, 5392.541633961, 5401.0, 5406.891862162656, 5472.452754724496, 5548.445155484419, 5575.609707320448, 5589.860253493533, 5609.719514024364, 5613.045782217115, 5408.513233808976, 5411.188321751769, 5428.864278392914, 5461.481159289861, 5509.944900551103], "unit": "score", "name": "dojo.html", "value": 5183.610102210604}, {"lowerIsBetter": false, "replicates": [486.868545492717, 512.7769420302171, 543.798794446055, 558.1850498272522, 558.8100045984366, 27570.310742231428, 35527.467087993704, 35556.64443355569, 35710.82144589273, 35744.2851142977, 38121.80939095307, 38908.80545597275, 38921.0, 38931.22137557247, 39020.609793902055, 8241.175882411771, 8367.163283671614, 8410.453320534176, 8436.57817109145, 8472.237498625123, 8242.134575869537, 8264.504129752204, 8290.875636865421, 8304.958475207615, 8319.0, 8302.377321700866, 8316.37627177961, 8339.498890199762, 8362.749117526453, 8364.58177091146, 8285.295749861269, 8290.08809031006, 8292.419530632858, 8431.072582015973, 8504.064552899175, 8376.623051962677, 8440.029396619406, 8498.277646400064, 8512.106228846005, 8528.6162122704, 38045.23909521822, 38794.418083728764, 38795.22409551793, 38960.22079558421, 39104.21791564153, 3104.5343198520177, 3120.937581248385, 3140.4661207594763, 3153.4008538377634, 3158.7946783459, 29001.0, 29007.70992290071, 29093.41813163725, 29781.851090744407, 30333.848330758206, 3773.962260377416, 3828.655421012122, 3829.100161462054, 3840.385538313856, 3907.5115610548683, 198031.0, 198518.0, 199004.0, 199624.00187999112, 199657.0, 50731.74634126806, 51834.74082629563, 54486.0, 55055.72472137614, 56981.0, 52025.219621705706, 52112.0, 52130.739346303024, 52133.478665213624, 52202.73898630482, 13853.584392468241, 14060.648483787987, 14126.152430853976, 14213.857861421253, 14220.431182752574, 10156.39061656303, 10236.846447303296, 10247.538860751283, 10283.897161028444, 10285.0, 18562.814371856108, 18681.626367472574, 18700.25198992052, 18844.0, 18903.24387024531, 7708.190639982721, 7910.683572657029, 7983.802429635602, 8030.718924837603, 8075.273225409741, 916.8028873792033, 980.9068138526828, 1017.9898201018043, 1018.85735996959, 1122.0630773304383, 25270.620940685905, 28291.71708282891, 29811.552826707615, 31007.84496077505, 31150.26413324912, 1000.9549570269355, 1019.3119644240256, 1030.6650338639972, 1046.5186014433293, 1123.269874581512, 13233.338333083308, 13375.799363009563, 13435.19388836673, 13526.93236533811, 13704.24626645544, 305770.0, 309686.0, 310560.0, 310566.0, 311310.0, 48388.516114839105, 48459.75770121127, 48894.75552622214, 48910.75544622254, 48931.75534122306, 1324.9403776829872, 1336.2717319061135, 1343.946242150303, 1350.439567579463, 1350.5948215535498, 24851.0, 25531.744682552937, 25538.872305638353, 25615.487690245718, 25768.0, 39252.803735981135, 39395.40906886342, 39465.60534394619, 39511.20977580375, 39710.0, 239060.0, 242552.0, 243826.6851994443, 292927.0, 293759.0, 30026.84986575053, 31548.52677209798, 32184.83907580447, 32352.676473234966, 32430.675693242767, 37661.246775064894, 38518.80740596279, 39765.403518947816, 40140.59859401369, 40831.0, 33586.49620255649, 33635.327293453505, 33954.83022584871, 34059.318813624086, 34514.654853451146, 34484.82757586296, 34625.30749385049, 34665.133371665914, 34995.825020874734, 35049.0, 35397.1150721234, 35586.11034724153, 35667.82166089153, 36268.637313626525, 36396.45405318975, 27917.58123628188, 27969.72030279671, 29695.25761855971, 30130.84934575313, 30213.697863021087, 23230.419239519146, 23338.299851004496, 23745.287641370785, 23843.830117057936, 24828.627570586093], "unit": "score", "name": "ext.html", "value": 17317.969651799427}, {"lowerIsBetter": false, "replicates": [360.3513675384309, 362.47803163444644, 362.9927401451971, 363.3332834249153, 364.1297299454303, 15499.922500387496, 16347.100909449975, 16669.749953750703, 17162.227699753526, 17421.47735567932, 10969.067629251504, 11342.489587968541, 16420.425285115023, 16449.753253701176, 16460.67078658426, 4635.930461043087, 5427.728613569326, 5445.401005889349, 5446.1558458439, 5474.260974768415, 5197.142471492218, 5297.523222909937, 5351.625386222966, 5351.7324133793345, 5429.945700543003, 5161.9483805162035, 5381.5425688816495, 5394.8921021579545, 5395.568354531648, 5396.676199428027, 5309.283246761676, 5315.495027972317, 5323.494268044529, 5347.679139251619, 5351.652142610737, 5310.415854256029, 5329.8934021319355, 5360.0083984463, 5376.650517716336, 5380.139177731583, 12394.876051239462, 16789.496315110566, 18030.0, 18693.252269909186, 18705.906470467697, 1910.2168111074532, 2064.95870082599, 2069.4515953272394, 2144.5179574688973, 2193.056985496236, 9513.429194248367, 11007.724806879893, 11212.495437705324, 12623.558175463906, 12995.220286782824, 1826.3060037185917, 1827.5248435406756, 1828.7896891857474, 1876.47458711561, 1876.80293569176, 54845.45154548444, 55193.0, 55279.0, 57101.85796284093, 57438.71280643612, 10024.298299119138, 10179.694609161737, 10235.334703244265, 10240.283180177315, 10324.432156231329, 13279.804817566466, 13295.268760218281, 13333.399997000159, 13371.33143342829, 13480.056396052181, 7197.568145911157, 7232.74685386009, 7238.348548630648, 7291.416686665054, 7361.926380736124, 6765.323467653294, 6905.551139175937, 6921.861562768717, 6990.61551614666, 6993.685284162225, 4405.977970110193, 4475.0, 4490.797914093873, 4496.348029535699, 4497.550244975476, 1794.6321004194108, 1797.0412250646596, 1838.5036040269054, 1863.338514827244, 1887.4054672778032, 812.6226046850531, 854.2909385210261, 900.8245933085794, 963.2486660404895, 1063.2079101069753, 15645.921770391304, 15680.843191568167, 15875.603109922113, 15957.281922313523, 16446.34214631425, 854.0861278432018, 904.1320332480892, 908.3959167153901, 932.7061975477703, 967.5162418790604, 5189.6886186828915, 8776.473411595325, 9019.864702029476, 9128.726138215865, 9797.516010477786, 373039.0, 383498.0, 385496.0, 551448.0, 559360.0, 58300.416995829495, 61014.69492652508, 61146.69426652927, 61647.0, 62353.688231559456, 1034.2294990232174, 1088.7659153282082, 1091.7980173667897, 1097.2209731090854, 1103.779244151173, 14440.133591984515, 14525.92737036308, 14730.926345368633, 14779.187144707144, 14860.925695371887, 31402.52896206513, 31518.842405787826, 31822.36355272835, 32172.13934327802, 32624.184395390304, 40275.79862100671, 40698.59301406948, 40701.778946631646, 41012.58987410088, 42511.0, 2796.7902407319125, 5516.0071187186695, 7088.255733147946, 7480.102387713509, 7644.503107298008, 10111.140553053074, 10415.68752937413, 11005.0, 11064.225504214628, 11270.94364528172, 9388.389754665925, 9648.179904708179, 9669.468179250209, 9780.804383912424, 9873.25950553697, 9577.185939195246, 9839.803203936024, 10002.0, 10137.341072830242, 10277.897221027693, 8088.555129467935, 10242.180625550087, 10244.53899574506, 10321.896781032094, 10422.218333624856, 7577.16651168382, 7604.0, 7850.960745196237, 7891.881621775563, 7935.880961785462, 9389.765255868659, 9977.501124943868, 10084.69745907624, 10197.0, 10200.28597998133], "unit": "score", "name": "jquery.html", "value": 7959.689712403322}, {"lowerIsBetter": false, "replicates": [1470.0665077675676, 1485.9034162779421, 1662.8170901200865, 1773.8846974946619, 1799.4511673939444, 7543.924560754391, 7597.962010189948, 7751.922480775191, 7807.804804879881, 7815.452918295721, 7843.960780196106, 7853.214678532144, 7869.80325491863, 7945.602719863999, 7956.045274567045, 2298.5058212484355, 2323.9883800581056, 2330.3707998840305, 2331.930042098731, 2333.1367394064137, 2326.906923723049, 2359.268626725712, 2364.9763502364926, 2365.1367250953363, 2376.4534157143867, 2245.247841972941, 2249.5388445368744, 2257.695211146499, 2264.071730590458, 2326.8603883767028, 2214.9114035438565, 2251.538434620899, 2273.056681477185, 2273.533925545259, 2274.920377786778, 2244.450109723128, 2270.4323919020244, 2279.3959600705825, 2284.5430913817136, 2288.4736510602656, 7350.154732205758, 7377.004104445885, 7406.0, 7408.296211859864, 7423.62881855905, 4670.883227919295, 4791.185498465269, 4811.398575178103, 4821.614270858323, 4859.757012149414, 3164.8259345735974, 3186.3308705171944, 3209.422303985282, 3223.2425380035675, 3226.951595726066, 1016.7153197104749, 1023.1303392116715, 1030.2530665267695, 1039.5270152080784, 1084.7071290751453, 10575.576976920915, 10649.201309901711, 10680.198985076073, 10762.408067556282, 10774.461276936201, 4200.85297014603, 4237.067845074079, 4322.675799315064, 4351.129774045204, 4407.140607581491, 9116.4074335168, 9130.26957843371, 9221.123993220634, 9235.584398702074, 9287.72136835896, 4820.542048505386, 4832.685875418087, 4849.80600775965, 4857.392825896763, 4883.145449546315, 4376.8905777355185, 4390.209762242763, 4435.1129774044675, 4437.290033594674, 4461.866144015685, 3642.1987162824134, 3649.50731651229, 3651.233241019416, 3686.2811751708696, 3689.981550092286, 1183.8342632031522, 1187.5131196209513, 1198.6044605280238, 1210.7639010393066, 1212.1878341511208, 987.9901200988041, 1000.0899181744578, 1119.2165484160957, 1135.8864113588575, 1268.9936550317188, 7341.3392794648735, 7443.069616297963, 7457.142428620669, 7469.066366704162, 7476.476646634792, 1080.4165750494644, 1090.0625462102585, 1092.7213560542011, 1117.6479408986143, 1120.5909842907442, 5756.107803290497, 5773.278340207474, 5785.913211301834, 5787.768489260467, 5839.766409343579, 9024.8646270306, 9219.400738951947, 9479.052094790604, 9483.430994140374, 9602.855957160647, 9278.164965153168, 9287.396319239362, 9302.906970930204, 9303.023182565868, 9506.857397139049, 7234.312740289664, 7316.707331706672, 7348.485606007635, 7359.374453171434, 7364.999999999893, 7046.718131274692, 7078.716851326095, 7086.397656199075, 7088.362047415757, 7101.928980710333, 8062.1534738853925, 8378.120297368689, 8381.832363352576, 8393.83212335762, 8446.113158118555, 8063.798405039921, 8211.83576328482, 8250.009998800182, 8250.958745206475, 8414.873776893473, 7207.9639601801655, 7410.851782964418, 7444.106707194955, 7477.887831682638, 7487.064116985377, 7467.551946883204, 7497.512661676974, 7506.136794268729, 7511.661975211238, 7513.248675132661, 6965.895511567432, 7090.929090709027, 7211.567305961659, 7262.9273707262255, 7398.889016664647, 6610.272869984202, 6717.017676099515, 6756.18925728896, 7010.334018268256, 7088.291170882871, 6726.495512836655, 6761.492888033319, 6785.762498312535, 6793.93206067933, 6836.453083753388, 6098.634081955097, 6323.304436512072, 6323.4625056868845, 6346.4605508532295, 6372.394622510854, 6282.685865706788, 6314.0, 6336.334684858023, 6370.426661600478, 6401.167848179707], "unit": "score", "name": "mootools.html", "value": 4511.2802253950795}, {"lowerIsBetter": false, "replicates": [333.8080603652899, 334.1945910356042, 336.3122414662016, 337.56285610134876, 345.7683352154057, 6294.811155665326, 6337.873242535146, 6342.14381058557, 6346.6509341986175, 6486.513511486633, 6280.403361680645, 6314.368563143684, 6327.0, 6351.872962540747, 6365.0, 4810.855674329776, 4814.566688997989, 4817.927731084036, 4821.590164835993, 4824.083424149418, 4807.831725889595, 4812.109759694467, 4816.662833601649, 4832.9275060874115, 4833.564979151894, 4678.994016286498, 4761.190597598399, 4770.260609605517, 4782.473927867949, 4782.97608511957, 4763.761811909408, 4767.856964291077, 4771.9761401192945, 4772.331873537708, 4773.618110551182, 4148.688848336356, 4152.979235103835, 4154.937675934863, 4163.937540936889, 4166.208420400114, 6032.698365081728, 6035.758569657209, 6039.3960603939695, 6041.214642096544, 6041.758329666808, 5399.5680345572655, 5567.109262517978, 5570.610057295991, 5571.637843540157, 5577.745007373349, 6669.599824010526, 6681.331866813329, 6685.43173830225, 6695.665216739192, 6696.330366963313, 4610.76946152691, 4614.723116613014, 4616.030633566921, 4626.629869610423, 4633.907321853544, 6727.360900714424, 6916.135483064617, 6933.826654333631, 7016.543924644881, 7025.946108083726, 4513.684042117086, 4528.573499347761, 4537.705049171794, 4539.182947069559, 4541.046380260183, 4580.221362368406, 4583.381243532147, 4584.404027476407, 4593.517680643551, 4597.35637010812, 5409.6213265071065, 5415.512603865671, 5421.457854214547, 5429.077056900336, 5432.375276843135, 6570.474362051024, 6714.865702685919, 6723.630200339028, 6727.394534491919, 6734.764283250161, 1624.84563966423, 1644.8190699023098, 1666.4084250091285, 1666.5500314914905, 1668.3243286468999, 1069.411823497089, 1073.3881687438086, 1074.4412905289205, 1086.8315411111291, 1100.3178029621527, 6236.376362363818, 6281.089242059876, 6286.0, 6288.968555157195, 6296.937030629635, 6786.151731033621, 6789.388954994074, 6810.523263371616, 6832.521723479408, 6834.965825170842, 6098.14625952367, 6223.315435302113, 6264.404881536247, 6279.811605651837, 6283.523372007575, 3717.275131349415, 3720.534933133358, 3723.925521489555, 3723.925521489555, 3724.1620635356826, 7111.7866464006165, 7122.964385178145, 7150.713971441188, 7161.89257161143, 7171.390431813355, 6898.965505172442, 6911.619860907698, 6966.268541803139, 6975.965120174468, 6978.406835419046, 7264.491485596063, 7268.0914885639295, 7271.054762880792, 7310.488265821447, 7350.3384695378745, 7007.859842803217, 7018.929810702032, 7024.754133605299, 7037.1555413350725, 7062.293770622897, 6831.521793474409, 6904.516683832285, 6908.274631163857, 6961.0, 6968.338007889242, 7309.378702810321, 7349.963250183715, 7351.485396022227, 7365.189829118685, 7368.078990126234, 4785.59322457595, 4798.184308667465, 4811.4707382188635, 4816.181249187576, 4816.54242846943, 6848.1097457330225, 6986.895196572157, 6992.370686638227, 6995.090638217, 6997.160340758938, 6777.1189745332795, 6788.389044985975, 6790.72837086511, 6846.760363387258, 6867.725290988505, 6723.159605049369, 6733.293004234485, 6750.628715420699, 6760.121184246016, 6769.966150169218, 6432.678366081584, 6552.27924928267, 6619.602823830585, 6624.436922861611, 6632.867342653217, 6767.187937447341, 6775.288594697683, 6777.491688123509, 6785.796426107225, 6803.965980170067, 6523.510736694672, 6554.14796076507, 6564.179477565304, 6569.638669873203, 6569.770058047945], "unit": "score", "name": "prototype.html", "value": 5018.295896709125}, {"lowerIsBetter": false, "replicates": [820.7701843483823, 822.087482893988, 824.9298809601183, 838.9932081502195, 845.188618925831, 13426.597202083942, 13522.256275904821, 13571.05002649815, 13597.932010339946, 13625.727485450298, 12733.490660373596, 12822.358882055883, 12823.935880320609, 13339.933300333509, 13783.931080344584, 798.48896706108, 814.633414963266, 816.6692489541745, 820.3806126374578, 821.2239433735123, 793.5199204481293, 802.173761026141, 808.3008197908796, 808.308895894011, 808.8180159464132, 856.8029353248756, 857.3312816003527, 858.9012263589674, 859.879616853641, 860.5826174305457, 853.9487630742144, 854.7692123126752, 856.0583358305876, 857.4169564696004, 860.2730692564835, 623.1151764494429, 624.9843753906143, 625.671522450717, 628.7045088808253, 631.4727202785633, 12570.497180112785, 12601.74796504074, 12624.81062784059, 12657.683557911127, 12684.619461416172, 12671.36643167838, 12687.238765674088, 12941.935290323489, 12960.48158073676, 13042.608721738363, 10229.948850255701, 10499.160067194682, 10553.577856885715, 10610.787784244349, 10668.679939601825, 3496.8950931472095, 3583.050491619723, 3587.964120358789, 3633.255182687543, 3654.451832225161, 44475.332870006976, 44674.0, 47368.28947565789, 52695.0, 54218.99999999961, 7991.320737737241, 8726.694565690297, 9466.621335146518, 9519.286053546011, 9578.377405468622, 17410.47768566945, 17527.123643818013, 17566.03386813712, 17606.0, 17646.735298970525, 6997.291435539172, 7154.034205382311, 7167.247439018932, 7174.892376614355, 7408.0, 4307.8492252771, 4401.867943961686, 4408.9859332353735, 4492.573205545468, 4542.613877820356, 2975.0777259049764, 2978.5234362501897, 2981.4335276297434, 2988.1035689293126, 2997.430488207234, 553.7840242305504, 567.6026781253139, 568.8407245971134, 569.6041251330369, 584.6316820403118, 476.5782282679853, 495.5861855350822, 551.3053552523769, 564.5177292299131, 583.2650859916536, 7798.805029874298, 7895.407844411692, 7929.881051784228, 8040.155783642634, 8332.875006874901, 509.6559822120054, 581.979630712923, 632.2665707778955, 632.8164832198703, 670.6780745242213, 3724.981375093107, 3777.150141218259, 3819.3698039823676, 3862.169633528749, 3900.8244628991765, 53860.46139538633, 55363.16955245675, 55417.722911385186, 55751.0, 55967.72016139893, 46661.0, 47394.54962679267, 47751.283730744064, 47890.28164577534, 47916.520834791205, 44232.557674423486, 44306.0, 44483.332750008776, 46092.07815843664, 46173.53826461759, 7807.687692492464, 7981.0, 8153.673853046049, 8287.83424331498, 8344.916550834414, 32153.517697234092, 33402.33195336128, 34164.82917585495, 34287.82856085704, 34398.14004649904, 43251.13497729965, 44104.0, 45930.0, 47113.764431177624, 47580.76209619068, 10129.797404051731, 10866.554407500722, 10904.61833835812, 11038.227324087558, 11239.213255072067, 11938.58214962472, 11982.64052078439, 12124.33316167584, 12330.506779729069, 12570.245785252548, 11019.118470522179, 11368.488418021043, 11582.88417115818, 11808.94095529517, 11855.043917753474, 10304.793904122025, 10362.288293202886, 10366.274360794672, 10427.524511272324, 10662.253642244968, 11235.943820280847, 11271.605493807678, 11590.826137607773, 11654.0, 11670.358130302915, 8840.0, 8942.195202431813, 8979.685711000084, 9320.860187097063, 9439.244860411289, 7773.339266162213, 8088.555129467935, 8112.959435202786, 8578.4424012439, 8613.870791938001], "unit": "score", "name": "yui.html", "value": 6134.566503235054}], "name": "dromaeo_css", "value": 6804.296678918499}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 111.0, 111.0, 124.0, 109.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 153.0, 169.0, 128.0, 160.0, 152.0, 139.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 162.0, 164.0, 163.0, 163.0, 163.0, 163.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 75.0, 73.0, 159.0, 76.0, 72.0, 72.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 145.0, 96.0, 97.0, 96.0, 143.0, 96.0, 101.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 68.0, 68.0, 69.0, 69.0, 67.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 91.0, 82.0, 85.0, 85.0, 84.0, 84.0, 84.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [123.0, 133.0, 114.0, 122.0, 119.0, 114.0, 115.0, 132.0, 132.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [137.0, 145.0, 145.0, 153.0, 136.0, 133.0, 152.0, 134.0, 151.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 70.0, 68.0, 68.0, 67.0, 70.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1520.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [693.000693000693], "unit": "score", "name": "Earley", "value": 961.7061090000003}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [41020.0], "unit": "score", "name": "RegExp", "value": 22.208313018039966}, {"lowerIsBetter": false, "replicates": [599.5203836930456], "unit": "score", "name": "Splay", "value": 135.92698800000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20411.501960923906}]} 16:35:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20411.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1520.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6804.30"}}} 16:35:44 INFO - Return code: 0 16:35:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:35:44 INFO - # TBPL SUCCESS # 16:35:44 INFO - Running post-action listener: _resource_record_post_action 16:35:44 INFO - Running post-run listener: _resource_record_post_run 16:35:45 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554524672; Read time: 80; Write time: 616124 16:35:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242937856; Read time: 0; Write time: 287100 16:35:45 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310988800; Read time: 80; Write time: 329024 16:35:45 INFO - Running post-run listener: _upload_blobber_files 16:35:45 INFO - Blob upload gear active. 16:35:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:35:45 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 16:35:45 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:35:45 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:35:46 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:47 INFO - (blobuploader) - INFO - Done attempting. 16:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:48 INFO - (blobuploader) - INFO - Done attempting. 16:35:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:48 INFO - Return code: 0 16:35:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:35:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6deeae670fe6b59ad2888924c174554c02e834741d8b51eaa2039dc7af0bfc446bc632039bea5fe9bb0831fa49f03918c43b311cd1927f6db73a36d9de8f10e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d510af7f4d6eb89c3f5838627eafc45748d44b6d2e7dc70ee1e071ac4c5887fc2d1ec6724a8ce88ba8bdd0e6e2d262e7b938a9280505dba91f9ad444d7343ffe"} 16:35:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:35:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:35:48 INFO - Contents: 16:35:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6deeae670fe6b59ad2888924c174554c02e834741d8b51eaa2039dc7af0bfc446bc632039bea5fe9bb0831fa49f03918c43b311cd1927f6db73a36d9de8f10e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d510af7f4d6eb89c3f5838627eafc45748d44b6d2e7dc70ee1e071ac4c5887fc2d1ec6724a8ce88ba8bdd0e6e2d262e7b938a9280505dba91f9ad444d7343ffe"} 16:35:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:48 INFO - Copying logs to upload dir... 16:35:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:35:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.000736 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-21 16:35:48.100728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 16:35:48.104060) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6deeae670fe6b59ad2888924c174554c02e834741d8b51eaa2039dc7af0bfc446bc632039bea5fe9bb0831fa49f03918c43b311cd1927f6db73a36d9de8f10e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d510af7f4d6eb89c3f5838627eafc45748d44b6d2e7dc70ee1e071ac4c5887fc2d1ec6724a8ce88ba8bdd0e6e2d262e7b938a9280505dba91f9ad444d7343ffe"} build_url:https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/RyP6cdJsRbalTbnc-ZT_4w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6deeae670fe6b59ad2888924c174554c02e834741d8b51eaa2039dc7af0bfc446bc632039bea5fe9bb0831fa49f03918c43b311cd1927f6db73a36d9de8f10e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d510af7f4d6eb89c3f5838627eafc45748d44b6d2e7dc70ee1e071ac4c5887fc2d1ec6724a8ce88ba8bdd0e6e2d262e7b938a9280505dba91f9ad444d7343ffe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 16:35:48.128447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:35:48.128755) ========= 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=eca2ab57546de7b41f256b19000001ef-1453419199.27623-1709379514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 16:35:48.212308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 16:35:48.212609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 16:35:48.212900) ========= ========= Total master_lag: 0.28 =========