builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1462252030.02 results: success (0) buildid: 20160502193607 builduid: 757bc65762604edab2471e2fea22f284 revision: 90382fbdad0061a7f0bc5d182ac750f813fd3d51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.019770) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.020927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.021341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.095962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.096298) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-02 22:07:12-- 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% 46.6M=0s 2016-05-02 22:07:12 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.209950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.210359) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018808 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:10.263502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-02 22:07:10.264088) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 90382fbdad0061a7f0bc5d182ac750f813fd3d51 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 90382fbdad0061a7f0bc5d182ac750f813fd3d51 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-02 22:07:12,360 truncating revision to first 12 chars 2016-05-02 22:07:12,360 Setting DEBUG logging. 2016-05-02 22:07:12,360 attempt 1/10 2016-05-02 22:07:12,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/90382fbdad00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-02 22:07:13,343 unpacking tar archive at: mozilla-inbound-90382fbdad00/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-02 22:07:11.517203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:11.517528) ========= script_repo_revision: 90382fbdad0061a7f0bc5d182ac750f813fd3d51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:11.518172) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:11.518664) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-02 22:07:11.527333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 29 secs) (at 2016-05-02 22:07:11.527642) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', '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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:13 INFO - MultiFileLogger online at 20160502 22:07:13 in /builds/slave/test 22:07:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:07:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:13 INFO - {'append_to_log': False, 22:07:13 INFO - 'base_work_dir': '/builds/slave/test', 22:07:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:07:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:13 INFO - 'branch': 'Mozilla-Inbound', 22:07:13 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:13 INFO - 'config_files': ('talos/linux_config.py',), 22:07:13 INFO - 'default_actions': ('clobber', 22:07:13 INFO - 'read-buildbot-config', 22:07:13 INFO - 'download-and-extract', 22:07:13 INFO - 'populate-webroot', 22:07:13 INFO - 'create-virtualenv', 22:07:13 INFO - 'install', 22:07:13 INFO - 'run-tests'), 22:07:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:13 INFO - 'download_minidump_stackwalk': True, 22:07:13 INFO - 'download_symbols': 'ondemand', 22:07:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:13 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:13 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:13 INFO - 'installer_path': 'installer.exe', 22:07:13 INFO - 'log_level': 'info', 22:07:13 INFO - 'log_name': 'talos', 22:07:13 INFO - 'log_to_console': True, 22:07:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:13 INFO - 'opt_config_files': (), 22:07:13 INFO - 'pip_index': False, 22:07:13 INFO - 'sps_profile': False, 22:07:13 INFO - 'sps_profile_interval': 0, 22:07:13 INFO - 'suite': 'dromaeojs', 22:07:13 INFO - 'system_bits': '32', 22:07:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:13 INFO - 'title': 'talos-linux64-ix-063', 22:07:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:13 INFO - 'use_talos_json': True, 22:07:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:13 INFO - 'work_dir': 'build'} 22:07:13 INFO - ##### 22:07:13 INFO - ##### Running clobber step. 22:07:13 INFO - ##### 22:07:13 INFO - Running pre-action listener: _resource_record_pre_action 22:07:13 INFO - Running main action method: clobber 22:07:13 INFO - rmtree: /builds/slave/test/build 22:07:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:14 INFO - Running post-action listener: _resource_record_post_action 22:07:14 INFO - ##### 22:07:14 INFO - ##### Running read-buildbot-config step. 22:07:14 INFO - ##### 22:07:14 INFO - Running pre-action listener: _resource_record_pre_action 22:07:14 INFO - Running main action method: read_buildbot_config 22:07:14 INFO - Using buildbot properties: 22:07:14 INFO - { 22:07:14 INFO - "project": "", 22:07:14 INFO - "product": "firefox", 22:07:14 INFO - "script_repo_revision": "production", 22:07:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:07:14 INFO - "repository": "", 22:07:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:07:14 INFO - "buildid": "20160502193607", 22:07:14 INFO - "pgo_build": "True", 22:07:14 INFO - "basedir": "/builds/slave/test", 22:07:14 INFO - "buildnumber": 884, 22:07:14 INFO - "slavename": "talos-linux64-ix-063", 22:07:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:07:14 INFO - "platform": "ubuntu64_hw", 22:07:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:07:14 INFO - "branch": "mozilla-inbound", 22:07:14 INFO - "repo_path": "integration/mozilla-inbound", 22:07:14 INFO - "revision": "90382fbdad0061a7f0bc5d182ac750f813fd3d51", 22:07:14 INFO - "stage_platform": "linux64-pgo", 22:07:14 INFO - "builduid": "757bc65762604edab2471e2fea22f284", 22:07:14 INFO - "slavebuilddir": "test" 22:07:14 INFO - } 22:07:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 22:07:14 INFO - Running post-action listener: _resource_record_post_action 22:07:14 INFO - ##### 22:07:14 INFO - ##### Running download-and-extract step. 22:07:14 INFO - ##### 22:07:14 INFO - Running pre-action listener: _resource_record_pre_action 22:07:14 INFO - Running main action method: download_and_extract 22:07:14 INFO - mkdir: /builds/slave/test/build/tests 22:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:14 INFO - https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:07:44 INFO - retry: attempt #1 caught exception: timed out 22:07:44 INFO - retry: Failed, sleeping 30 seconds before retrying 22:08:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 22:08:44 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:08:44 INFO - retry: attempt #2 caught exception: timed out 22:08:44 INFO - retry: Failed, sleeping 60 seconds before retrying 22:09:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #3 22:10:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:10:14 INFO - retry: attempt #3 caught exception: timed out 22:10:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json! 22:10:14 INFO - Caught exception: timed out 22:10:14 INFO - Caught exception: timed out 22:10:14 INFO - Caught exception: timed out 22:10:14 INFO - trying https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:14 INFO - Downloading https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:10:15 INFO - Downloaded 1361 bytes. 22:10:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:10:15 INFO - Using the following test package requirements: 22:10:15 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:15 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:10:15 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:10:15 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'jsshell-linux-x86_64.zip'], 22:10:15 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:10:15 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:10:15 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:10:15 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:10:15 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:10:15 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:10:15 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:10:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:10:15 INFO - https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:10:45 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:10:45 INFO - retry: attempt #1 caught exception: timed out 22:10:45 INFO - retry: Failed, sleeping 30 seconds before retrying 22:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:11:45 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:11:45 INFO - retry: attempt #2 caught exception: timed out 22:11:45 INFO - retry: Failed, sleeping 60 seconds before retrying 22:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:13:15 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:13:15 INFO - retry: attempt #3 caught exception: timed out 22:13:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 22:13:15 INFO - Caught exception: timed out 22:13:15 INFO - Caught exception: timed out 22:13:15 INFO - Caught exception: timed out 22:13:15 INFO - trying https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:15 INFO - Downloading https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:16 INFO - Downloaded 23878528 bytes. 22:13:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:17 INFO - Return code: 0 22:13:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:13:47 INFO - retry: attempt #1 caught exception: timed out 22:13:47 INFO - retry: Failed, sleeping 30 seconds before retrying 22:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:14:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:14:47 INFO - retry: attempt #2 caught exception: timed out 22:14:47 INFO - retry: Failed, sleeping 60 seconds before retrying 22:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:16:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:16:17 INFO - retry: attempt #3 caught exception: timed out 22:16:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 22:16:17 INFO - Caught exception: timed out 22:16:17 INFO - Caught exception: timed out 22:16:17 INFO - Caught exception: timed out 22:16:17 INFO - trying https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:18 INFO - Downloaded 23878528 bytes. 22:16:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:16:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:16:20 INFO - Return code: 0 22:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:20 INFO - https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:16:50 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:16:50 INFO - retry: attempt #1 caught exception: timed out 22:16:50 INFO - retry: Failed, sleeping 30 seconds before retrying 22:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 22:17:50 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:17:50 INFO - retry: attempt #2 caught exception: timed out 22:17:50 INFO - retry: Failed, sleeping 60 seconds before retrying 22:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 22:19:20 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:19:20 INFO - retry: attempt #3 caught exception: timed out 22:19:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip! 22:19:20 INFO - Caught exception: timed out 22:19:20 INFO - Caught exception: timed out 22:19:20 INFO - Caught exception: timed out 22:19:20 INFO - trying https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:19:20 INFO - Downloading https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:19:21 INFO - Downloaded 10840152 bytes. 22:19:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:19:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:19:21 INFO - Return code: 0 22:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:19:21 INFO - https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:19:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:19:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:19:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:19:51 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:19:51 INFO - retry: attempt #1 caught exception: timed out 22:19:51 INFO - retry: Failed, sleeping 30 seconds before retrying 22:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 22:20:51 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:20:51 INFO - retry: attempt #2 caught exception: timed out 22:20:51 INFO - retry: Failed, sleeping 60 seconds before retrying 22:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #3 22:22:21 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:22:21 INFO - retry: attempt #3 caught exception: timed out 22:22:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 22:22:21 INFO - Caught exception: timed out 22:22:21 INFO - Caught exception: timed out 22:22:21 INFO - Caught exception: timed out 22:22:21 INFO - trying https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:22:21 INFO - Downloading https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:22:23 INFO - Downloaded 58607883 bytes. 22:22:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:22:23 INFO - mkdir: /builds/slave/test/properties 22:22:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:23 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:23 INFO - Contents: 22:22:23 INFO - build_url:https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:22:24 INFO - Running post-action listener: _resource_record_post_action 22:22:24 INFO - Running post-action listener: set_extra_try_arguments 22:22:24 INFO - ##### 22:22:24 INFO - ##### Running populate-webroot step. 22:22:24 INFO - ##### 22:22:24 INFO - Running pre-action listener: _resource_record_pre_action 22:22:24 INFO - Running main action method: populate_webroot 22:22:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:24 INFO - '--tppagecycles', 22:22:24 INFO - '7'], 22:22:24 INFO - 'tests': ['tsvgm']}}, 22:22:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:22:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:22:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['damp', 'tps']}, 22:22:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'tests': ['damp', 'tps']}, 22:22:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['dromaeo_dom']}, 22:22:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'other-e10s': {'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['a11yr', 22:22:24 INFO - 'ts_paint', 22:22:24 INFO - 'tpaint', 22:22:24 INFO - 'sessionrestore', 22:22:24 INFO - 'sessionrestore_no_auto_restore', 22:22:24 INFO - 'tabpaint']}, 22:22:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['tsvgx', 22:22:24 INFO - 'tsvgr_opacity', 22:22:24 INFO - 'tart', 22:22:24 INFO - 'tscrollx', 22:22:24 INFO - 'cart']}, 22:22:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:22:24 INFO - 'tsvgr_opacity', 22:22:24 INFO - 'tart', 22:22:24 INFO - 'tscrollx', 22:22:24 INFO - 'cart']}, 22:22:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'talos_options': ['--disable-e10s'], 22:22:24 INFO - 'tests': ['tp5o']}, 22:22:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'tests': ['tp5o']}, 22:22:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'talos_options': ['--disable-e10s', 22:22:24 INFO - '--xperf_path', 22:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:24 INFO - 'tests': ['tp5n']}, 22:22:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:24 INFO - 'talos_options': ['--xperf_path', 22:22:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:24 INFO - 'tests': ['tp5n']}}, 22:22:24 INFO - 'talos.zip': {'path': '', 22:22:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:24 INFO - Running post-action listener: _resource_record_post_action 22:22:24 INFO - ##### 22:22:24 INFO - ##### Running create-virtualenv step. 22:22:24 INFO - ##### 22:22:24 INFO - Running pre-action listener: _resource_record_pre_action 22:22:24 INFO - Running main action method: create_virtualenv 22:22:24 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:22:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:24 INFO - Using real prefix '/usr' 22:22:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:24 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:26 INFO - Installing pip.................done. 22:22:26 INFO - Return code: 0 22:22:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:26 INFO - Running command: ['/builds/slave/test/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/build 22:22:26 INFO - Copy/paste: /builds/slave/test/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 22:22:26 INFO - Using env: {'DISPLAY': ':0', 22:22:26 INFO - 'HOME': '/home/cltbld', 22:22:26 INFO - 'LANG': 'en_US.UTF-8', 22:22:26 INFO - 'LANGUAGE': 'en_US:en', 22:22:26 INFO - 'LOGNAME': 'cltbld', 22:22:26 INFO - 'MAIL': '/var/mail/cltbld', 22:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:26 INFO - 'MOZ_NO_REMOTE': '1', 22:22:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:26 INFO - 'NO_EM_RESTART': '1', 22:22:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:26 INFO - 'PWD': '/builds/slave/test', 22:22:26 INFO - 'SHELL': '/bin/bash', 22:22:26 INFO - 'SHLVL': '1', 22:22:26 INFO - 'TERM': 'linux', 22:22:26 INFO - 'TMOUT': '86400', 22:22:26 INFO - 'USER': 'cltbld', 22:22:26 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:26 INFO - '_': '/tools/buildbot/bin/python'} 22:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:22:27 INFO - Cleaning up... 22:22:27 INFO - Return code: 0 22:22:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:27 INFO - Running command: ['/builds/slave/test/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/build 22:22:27 INFO - Copy/paste: /builds/slave/test/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 22:22:27 INFO - Using env: {'DISPLAY': ':0', 22:22:27 INFO - 'HOME': '/home/cltbld', 22:22:27 INFO - 'LANG': 'en_US.UTF-8', 22:22:27 INFO - 'LANGUAGE': 'en_US:en', 22:22:27 INFO - 'LOGNAME': 'cltbld', 22:22:27 INFO - 'MAIL': '/var/mail/cltbld', 22:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:27 INFO - 'MOZ_NO_REMOTE': '1', 22:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:27 INFO - 'NO_EM_RESTART': '1', 22:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:27 INFO - 'PWD': '/builds/slave/test', 22:22:27 INFO - 'SHELL': '/bin/bash', 22:22:27 INFO - 'SHLVL': '1', 22:22:27 INFO - 'TERM': 'linux', 22:22:27 INFO - 'TMOUT': '86400', 22:22:27 INFO - 'USER': 'cltbld', 22:22:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:27 INFO - '_': '/tools/buildbot/bin/python'} 22:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:27 INFO - Downloading/unpacking psutil>=0.7.1 22:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:29 INFO - Installing collected packages: psutil 22:22:29 INFO - Running setup.py install for psutil 22:22:29 INFO - building 'psutil._psutil_linux' extension 22:22:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:22:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:22:29 INFO - building 'psutil._psutil_posix' extension 22:22:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:22:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:22:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:29 INFO - Successfully installed psutil 22:22:29 INFO - Cleaning up... 22:22:29 INFO - Return code: 0 22:22:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:29 INFO - Running command: ['/builds/slave/test/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/build 22:22:29 INFO - Copy/paste: /builds/slave/test/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 22:22:29 INFO - Using env: {'DISPLAY': ':0', 22:22:29 INFO - 'HOME': '/home/cltbld', 22:22:29 INFO - 'LANG': 'en_US.UTF-8', 22:22:29 INFO - 'LANGUAGE': 'en_US:en', 22:22:29 INFO - 'LOGNAME': 'cltbld', 22:22:29 INFO - 'MAIL': '/var/mail/cltbld', 22:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:29 INFO - 'MOZ_NO_REMOTE': '1', 22:22:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:29 INFO - 'NO_EM_RESTART': '1', 22:22:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:29 INFO - 'PWD': '/builds/slave/test', 22:22:29 INFO - 'SHELL': '/bin/bash', 22:22:29 INFO - 'SHLVL': '1', 22:22:29 INFO - 'TERM': 'linux', 22:22:29 INFO - 'TMOUT': '86400', 22:22:29 INFO - 'USER': 'cltbld', 22:22:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:29 INFO - '_': '/tools/buildbot/bin/python'} 22:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:22:32 INFO - Installing collected packages: mozsystemmonitor 22:22:32 INFO - Running setup.py install for mozsystemmonitor 22:22:32 INFO - Successfully installed mozsystemmonitor 22:22:32 INFO - Cleaning up... 22:22:32 INFO - Return code: 0 22:22:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:32 INFO - Running command: ['/builds/slave/test/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/build 22:22:32 INFO - Copy/paste: /builds/slave/test/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 22:22:32 INFO - Using env: {'DISPLAY': ':0', 22:22:32 INFO - 'HOME': '/home/cltbld', 22:22:32 INFO - 'LANG': 'en_US.UTF-8', 22:22:32 INFO - 'LANGUAGE': 'en_US:en', 22:22:32 INFO - 'LOGNAME': 'cltbld', 22:22:32 INFO - 'MAIL': '/var/mail/cltbld', 22:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:32 INFO - 'MOZ_NO_REMOTE': '1', 22:22:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:32 INFO - 'NO_EM_RESTART': '1', 22:22:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:32 INFO - 'PWD': '/builds/slave/test', 22:22:32 INFO - 'SHELL': '/bin/bash', 22:22:32 INFO - 'SHLVL': '1', 22:22:32 INFO - 'TERM': 'linux', 22:22:32 INFO - 'TMOUT': '86400', 22:22:32 INFO - 'USER': 'cltbld', 22:22:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:32 INFO - '_': '/tools/buildbot/bin/python'} 22:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:32 INFO - Downloading/unpacking blobuploader==1.2.4 22:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:22:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:22:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:35 INFO - Downloading docopt-0.6.1.tar.gz 22:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:22:35 INFO - Installing collected packages: blobuploader, requests, docopt 22:22:35 INFO - Running setup.py install for blobuploader 22:22:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:22:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:22:35 INFO - Running setup.py install for requests 22:22:35 INFO - Running setup.py install for docopt 22:22:35 INFO - Successfully installed blobuploader requests docopt 22:22:35 INFO - Cleaning up... 22:22:35 INFO - Return code: 0 22:22:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 22:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:35 INFO - Using env: {'DISPLAY': ':0', 22:22:35 INFO - 'HOME': '/home/cltbld', 22:22:35 INFO - 'LANG': 'en_US.UTF-8', 22:22:35 INFO - 'LANGUAGE': 'en_US:en', 22:22:35 INFO - 'LOGNAME': 'cltbld', 22:22:35 INFO - 'MAIL': '/var/mail/cltbld', 22:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:35 INFO - 'MOZ_NO_REMOTE': '1', 22:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:35 INFO - 'NO_EM_RESTART': '1', 22:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:35 INFO - 'PWD': '/builds/slave/test', 22:22:35 INFO - 'SHELL': '/bin/bash', 22:22:35 INFO - 'SHLVL': '1', 22:22:35 INFO - 'TERM': 'linux', 22:22:35 INFO - 'TMOUT': '86400', 22:22:35 INFO - 'USER': 'cltbld', 22:22:35 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:35 INFO - '_': '/tools/buildbot/bin/python'} 22:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:35 INFO - Running setup.py (path:/tmp/pip-AK0X65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:35 INFO - Running setup.py (path:/tmp/pip-2dZ8dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:36 INFO - Running setup.py (path:/tmp/pip-42lymK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:36 INFO - Running setup.py (path:/tmp/pip-M3QOUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:36 INFO - Running setup.py (path:/tmp/pip-qfmFiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:36 INFO - Running setup.py (path:/tmp/pip-2k0kKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:36 INFO - Running setup.py (path:/tmp/pip-DOR5TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:36 INFO - Running setup.py (path:/tmp/pip-kUyq08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:36 INFO - Running setup.py (path:/tmp/pip-kuC8Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:36 INFO - Running setup.py (path:/tmp/pip-sKPRdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:36 INFO - Running setup.py (path:/tmp/pip-nx23WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:36 INFO - Running setup.py (path:/tmp/pip-jOVX3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:36 INFO - Running setup.py (path:/tmp/pip-bJxrdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:36 INFO - Running setup.py (path:/tmp/pip-eKnTp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:36 INFO - Running setup.py (path:/tmp/pip-BEPXof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:36 INFO - Running setup.py (path:/tmp/pip-JPyyx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:37 INFO - Running setup.py (path:/tmp/pip-jnFsb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:22:37 INFO - Running setup.py install for manifestparser 22:22:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Running setup.py install for mozcrash 22:22:37 INFO - Running setup.py install for mozdebug 22:22:37 INFO - Running setup.py install for mozdevice 22:22:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Running setup.py install for mozfile 22:22:37 INFO - Running setup.py install for mozhttpd 22:22:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Running setup.py install for mozinfo 22:22:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Running setup.py install for mozInstall 22:22:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:22:37 INFO - Running setup.py install for mozleak 22:22:38 INFO - Running setup.py install for mozlog 22:22:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Running setup.py install for moznetwork 22:22:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Running setup.py install for mozprocess 22:22:38 INFO - Running setup.py install for mozprofile 22:22:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Running setup.py install for mozrunner 22:22:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Running setup.py install for mozscreenshot 22:22:38 INFO - Running setup.py install for moztest 22:22:38 INFO - Running setup.py install for mozversion 22:22:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:22:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:22:38 INFO - Cleaning up... 22:22:38 INFO - Return code: 0 22:22:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 22:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:38 INFO - Using env: {'DISPLAY': ':0', 22:22:38 INFO - 'HOME': '/home/cltbld', 22:22:38 INFO - 'LANG': 'en_US.UTF-8', 22:22:38 INFO - 'LANGUAGE': 'en_US:en', 22:22:38 INFO - 'LOGNAME': 'cltbld', 22:22:38 INFO - 'MAIL': '/var/mail/cltbld', 22:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:38 INFO - 'MOZ_NO_REMOTE': '1', 22:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:38 INFO - 'NO_EM_RESTART': '1', 22:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:38 INFO - 'PWD': '/builds/slave/test', 22:22:38 INFO - 'SHELL': '/bin/bash', 22:22:38 INFO - 'SHLVL': '1', 22:22:38 INFO - 'TERM': 'linux', 22:22:38 INFO - 'TMOUT': '86400', 22:22:38 INFO - 'USER': 'cltbld', 22:22:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:38 INFO - '_': '/tools/buildbot/bin/python'} 22:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:39 INFO - Running setup.py (path:/tmp/pip-pKWwwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:39 INFO - Running setup.py (path:/tmp/pip-9Wh_UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:39 INFO - Running setup.py (path:/tmp/pip-8Q8pNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:39 INFO - Running setup.py (path:/tmp/pip-bVSxbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:39 INFO - Running setup.py (path:/tmp/pip-cUoCYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:39 INFO - Running setup.py (path:/tmp/pip-oWbZK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:39 INFO - Running setup.py (path:/tmp/pip-RI3tAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:39 INFO - Running setup.py (path:/tmp/pip-jbnsFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:39 INFO - Running setup.py (path:/tmp/pip-3rLsxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:39 INFO - Running setup.py (path:/tmp/pip-CxGtoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:39 INFO - Running setup.py (path:/tmp/pip-LodJZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:22:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:39 INFO - Running setup.py (path:/tmp/pip-NkWZjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:40 INFO - Running setup.py (path:/tmp/pip-bIN8zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:40 INFO - Running setup.py (path:/tmp/pip-NM6dKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:40 INFO - Running setup.py (path:/tmp/pip-BZHXdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:40 INFO - Running setup.py (path:/tmp/pip-JnXmTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:40 INFO - Running setup.py (path:/tmp/pip-7a64jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:22:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:42 INFO - Downloading blessings-1.6.tar.gz 22:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:22:42 INFO - Installing collected packages: blessings 22:22:42 INFO - Running setup.py install for blessings 22:22:42 INFO - Successfully installed blessings 22:22:42 INFO - Cleaning up... 22:22:42 INFO - Return code: 0 22:22:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:42 INFO - Reading from file tmpfile_stdout 22:22:42 INFO - Current package versions: 22:22:42 INFO - argparse == 1.2.1 22:22:42 INFO - blessings == 1.6 22:22:42 INFO - blobuploader == 1.2.4 22:22:42 INFO - docopt == 0.6.1 22:22:42 INFO - manifestparser == 1.1 22:22:42 INFO - mozInstall == 1.12 22:22:42 INFO - mozcrash == 0.17 22:22:42 INFO - mozdebug == 0.1 22:22:42 INFO - mozdevice == 0.48 22:22:42 INFO - mozfile == 1.2 22:22:42 INFO - mozhttpd == 0.7 22:22:42 INFO - mozinfo == 0.9 22:22:42 INFO - mozleak == 0.1 22:22:42 INFO - mozlog == 3.1 22:22:42 INFO - moznetwork == 0.27 22:22:42 INFO - mozprocess == 0.22 22:22:42 INFO - mozprofile == 0.28 22:22:42 INFO - mozrunner == 6.11 22:22:42 INFO - mozscreenshot == 0.1 22:22:42 INFO - mozsystemmonitor == 0.0 22:22:42 INFO - moztest == 0.7 22:22:42 INFO - mozversion == 1.4 22:22:42 INFO - psutil == 3.1.1 22:22:42 INFO - requests == 1.2.3 22:22:42 INFO - wsgiref == 0.1.2 22:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 22:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:42 INFO - Using env: {'DISPLAY': ':0', 22:22:42 INFO - 'HOME': '/home/cltbld', 22:22:42 INFO - 'LANG': 'en_US.UTF-8', 22:22:42 INFO - 'LANGUAGE': 'en_US:en', 22:22:42 INFO - 'LOGNAME': 'cltbld', 22:22:42 INFO - 'MAIL': '/var/mail/cltbld', 22:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:42 INFO - 'MOZ_NO_REMOTE': '1', 22:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:42 INFO - 'NO_EM_RESTART': '1', 22:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:42 INFO - 'PWD': '/builds/slave/test', 22:22:42 INFO - 'SHELL': '/bin/bash', 22:22:42 INFO - 'SHLVL': '1', 22:22:42 INFO - 'TERM': 'linux', 22:22:42 INFO - 'TMOUT': '86400', 22:22:42 INFO - 'USER': 'cltbld', 22:22:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:42 INFO - '_': '/tools/buildbot/bin/python'} 22:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:22:42 INFO - Cleaning up... 22:22:42 INFO - Return code: 0 22:22:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:42 INFO - Running command: ['/builds/slave/test/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/build 22:22:42 INFO - Copy/paste: /builds/slave/test/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 22:22:42 INFO - Using env: {'DISPLAY': ':0', 22:22:42 INFO - 'HOME': '/home/cltbld', 22:22:42 INFO - 'LANG': 'en_US.UTF-8', 22:22:42 INFO - 'LANGUAGE': 'en_US:en', 22:22:42 INFO - 'LOGNAME': 'cltbld', 22:22:42 INFO - 'MAIL': '/var/mail/cltbld', 22:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:42 INFO - 'MOZ_NO_REMOTE': '1', 22:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:42 INFO - 'NO_EM_RESTART': '1', 22:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:42 INFO - 'PWD': '/builds/slave/test', 22:22:42 INFO - 'SHELL': '/bin/bash', 22:22:42 INFO - 'SHLVL': '1', 22:22:42 INFO - 'TERM': 'linux', 22:22:42 INFO - 'TMOUT': '86400', 22:22:42 INFO - 'USER': 'cltbld', 22:22:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:42 INFO - '_': '/tools/buildbot/bin/python'} 22:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:43 INFO - Downloading/unpacking jsonschema 22:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:22:44 INFO - Downloading/unpacking functools32 (from jsonschema) 22:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:45 INFO - Downloading functools32-3.2.3-2.tar.gz 22:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:22:45 INFO - warning: no files found matching '*.txt' 22:22:45 INFO - no previously-included directories found matching 'build' 22:22:45 INFO - no previously-included directories found matching 'dist' 22:22:45 INFO - no previously-included directories found matching '.git*' 22:22:45 INFO - Installing collected packages: jsonschema, functools32 22:22:45 INFO - Running setup.py install for functools32 22:22:45 INFO - warning: no files found matching '*.txt' 22:22:45 INFO - no previously-included directories found matching 'build' 22:22:45 INFO - no previously-included directories found matching 'dist' 22:22:45 INFO - no previously-included directories found matching '.git*' 22:22:45 INFO - Successfully installed jsonschema functools32 22:22:45 INFO - Cleaning up... 22:22:45 INFO - Return code: 0 22:22:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fd35d9a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:45 INFO - Running command: ['/builds/slave/test/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/build 22:22:45 INFO - Copy/paste: /builds/slave/test/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 22:22:45 INFO - Using env: {'DISPLAY': ':0', 22:22:45 INFO - 'HOME': '/home/cltbld', 22:22:45 INFO - 'LANG': 'en_US.UTF-8', 22:22:45 INFO - 'LANGUAGE': 'en_US:en', 22:22:45 INFO - 'LOGNAME': 'cltbld', 22:22:45 INFO - 'MAIL': '/var/mail/cltbld', 22:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:45 INFO - 'MOZ_NO_REMOTE': '1', 22:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:45 INFO - 'NO_EM_RESTART': '1', 22:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:45 INFO - 'PWD': '/builds/slave/test', 22:22:45 INFO - 'SHELL': '/bin/bash', 22:22:45 INFO - 'SHLVL': '1', 22:22:45 INFO - 'TERM': 'linux', 22:22:45 INFO - 'TMOUT': '86400', 22:22:45 INFO - 'USER': 'cltbld', 22:22:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:45 INFO - '_': '/tools/buildbot/bin/python'} 22:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:45 INFO - Downloading/unpacking flake8 22:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:22:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:22:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:22:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:22:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:22:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:22:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:22:48 INFO - no previously-included directories found matching 'docs/_build' 22:22:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:22:48 INFO - Running setup.py install for pep8 22:22:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:22:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:22:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:22:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:22:48 INFO - no previously-included directories found matching 'docs/_build' 22:22:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:22:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:22:48 INFO - Cleaning up... 22:22:48 INFO - Return code: 0 22:22:48 INFO - Running post-action listener: _resource_record_post_action 22:22:48 INFO - Running post-action listener: _start_resource_monitoring 22:22:48 INFO - Starting resource monitoring. 22:22:48 INFO - ##### 22:22:48 INFO - ##### Running install step. 22:22:48 INFO - ##### 22:22:48 INFO - Running pre-action listener: _resource_record_pre_action 22:22:48 INFO - Running main action method: install 22:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:22:48 INFO - Reading from file tmpfile_stdout 22:22:48 INFO - Detecting whether we're running mozinstall >=1.0... 22:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:22:48 INFO - Reading from file tmpfile_stdout 22:22:48 INFO - Output received: 22:22:48 INFO - Usage: mozinstall [options] installer 22:22:48 INFO - Options: 22:22:48 INFO - -h, --help show this help message and exit 22:22:48 INFO - -d DEST, --destination=DEST 22:22:48 INFO - Directory to install application into. [default: 22:22:48 INFO - "/builds/slave/test"] 22:22:48 INFO - --app=APP Application being installed. [default: firefox] 22:22:48 INFO - mkdir: /builds/slave/test/build/application 22:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:23:05 INFO - Reading from file tmpfile_stdout 22:23:05 INFO - Output received: 22:23:05 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:05 INFO - Running post-action listener: _resource_record_post_action 22:23:05 INFO - ##### 22:23:05 INFO - ##### Running run-tests step. 22:23:05 INFO - ##### 22:23:05 INFO - Running pre-action listener: _resource_record_pre_action 22:23:05 INFO - Running main action method: run_tests 22:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:05 INFO - Python 2.7.3 22:23:05 INFO - Return code: 0 22:23:05 INFO - grabbing minidump binary from tooltool 22:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:05 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/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 0x1ba8410>, '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 0x1ba9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:23:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:23:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:05 INFO - Return code: 0 22:23:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:23:06 INFO - Return code: 0 22:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:23:06 INFO - Using env: {'DISPLAY': ':0', 22:23:06 INFO - 'HOME': '/home/cltbld', 22:23:06 INFO - 'LANG': 'en_US.UTF-8', 22:23:06 INFO - 'LANGUAGE': 'en_US:en', 22:23:06 INFO - 'LOGNAME': 'cltbld', 22:23:06 INFO - 'MAIL': '/var/mail/cltbld', 22:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:06 INFO - 'MOZ_NO_REMOTE': '1', 22:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:06 INFO - 'NO_EM_RESTART': '1', 22:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:06 INFO - 'PWD': '/builds/slave/test', 22:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:06 INFO - 'SHELL': '/bin/bash', 22:23:06 INFO - 'SHLVL': '1', 22:23:06 INFO - 'TERM': 'linux', 22:23:06 INFO - 'TMOUT': '86400', 22:23:06 INFO - 'USER': 'cltbld', 22:23:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003', 22:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:06 INFO - '_': '/tools/buildbot/bin/python'} 22:23:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:23:06 INFO - mozversion application_buildid: 20160502193607 22:23:06 INFO - mozversion application_changeset: 90382fbdad0061a7f0bc5d182ac750f813fd3d51 22:23:06 INFO - mozversion application_display_name: Nightly 22:23:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:06 INFO - mozversion application_name: Firefox 22:23:06 INFO - mozversion application_remotingname: firefox 22:23:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:23:06 INFO - mozversion application_vendor: Mozilla 22:23:06 INFO - mozversion application_version: 49.0a1 22:23:06 INFO - mozversion platform_buildid: 20160502193607 22:23:06 INFO - mozversion platform_changeset: 90382fbdad0061a7f0bc5d182ac750f813fd3d51 22:23:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:23:06 INFO - mozversion platform_version: 49.0a1 22:23:06 INFO - using testdate: 1462252986 22:23:06 INFO - actual date: 1462252986 22:23:06 INFO - starting webserver on 'localhost:51241' 22:23:06 INFO - SUITE-START | Running 2 tests 22:23:06 INFO - TEST-START | dromaeo_css 22:23:06 INFO - operating with platform_type : linux_ 22:23:06 INFO - Initialising browser for dromaeo_css test... 22:23:06 INFO - TEST-INFO | started process 19655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQC1Ee/profile http://localhost:51241/getInfo.html) 22:23:11 INFO - PROCESS | 19655 | __metrics Screen width/height:1600/1200 22:23:11 INFO - PROCESS | 19655 | colorDepth:24 22:23:11 INFO - PROCESS | 19655 | Browser inner width/height: 1024/697 22:23:11 INFO - PROCESS | 19655 | __metrics 22:23:12 ERROR - PROCESS | 19655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:23:13 INFO - TEST-INFO | 19655: exit 0 22:23:13 INFO - Browser initialized. 22:23:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:23:13 INFO - TEST-INFO | started process 19741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPQC1Ee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:24 INFO - PROCESS | 19741 | RSS: Main: 154927104 22:23:24 INFO - PROCESS | 19741 | 22:24:15 INFO - PROCESS | 19741 | 1462253055917 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] 22:26:23 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51241/tests/dromaeo/cssquery-ext.html) 22:26:24 INFO - PROCESS | 19741 | RSS: Main: 234496000 22:26:24 INFO - PROCESS | 19741 | 22:29:26 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-ext.html (next: http://localhost:51241/tests/dromaeo/cssquery-jquery.html) 22:29:27 INFO - PROCESS | 19741 | RSS: Main: 237412352 22:29:27 INFO - PROCESS | 19741 | 22:32:28 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51241/tests/dromaeo/cssquery-mootools.html) 22:32:29 INFO - PROCESS | 19741 | RSS: Main: 235450368 22:32:29 INFO - PROCESS | 19741 | 22:35:31 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51241/tests/dromaeo/cssquery-prototype.html) 22:35:31 INFO - PROCESS | 19741 | RSS: Main: 232931328 22:35:31 INFO - PROCESS | 19741 | 22:38:34 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51241/tests/dromaeo/cssquery-yui.html) 22:38:35 INFO - PROCESS | 19741 | RSS: Main: 223137792 22:38:35 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:51241/tests/dromaeo/cssquery-yui.html (next: http://localhost:51241/tests/dromaeo/cssquery-dojo.html) 22:41:37 INFO - PROCESS | 19741 | RSS: Main: 269893632 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | __start_tp_report 22:41:37 INFO - PROCESS | 19741 | _x_x_mozilla_page_load 22:41:37 INFO - PROCESS | 19741 | _x_x_mozilla_page_load_details 22:41:37 INFO - PROCESS | 19741 | |i|pagename|runs| 22:41:37 INFO - PROCESS | 19741 | |0;dojo.html;3041.361314124034;3078.39971205615;3125.7655675824317;3135.2161959510136;3165.873365065398;5057.140286151354;5117.641765076446;5172.844814655562;5180.430152683207;5218.347706536683;5157.406898206707;5192.584593232542;5218.32161818963;5244.239585260135;5288.762005709743;4680.976595117019;4724.078804633098;4729.834455794031;4790.568848803607;4869.805207791702;4766.952330476685;4832.71003739775;4834.347363105989;4837.250226214942;4863.5865951394;4640.79116439761;4657.976710116462;4663.323818046399;4736.265878788793;4803.423589169287;4712.269598212282;4737.052589482083;4748.57262846342;4749.62003039756;4793.71237725734;4636.86089417318;4651.093036857814;4655.604273636745;4666.673332866701;4699.906001879977;5051.570616497602;5069.264956581275;5106.234064890259;5209.947900520984;5224;5437.13005919051;5465.699386533739;5482.643628164196;5489.835304940858;5495.587830912697;5484.067708489566;5496.422875598045;5497.642653227527;5499.065158922993;5502.752376143083;5071.2139618359215;5089.618278629117;5116.897662046738;5190.506901844356;5193.143131383317;5628.2683251177905;5631.493165615114;5634.492895639412;5635.971820140873;5670.744816483269;5250.291210686509;5384.730763461811;5407.864803379868;5414.945850541523;5415.296011518478;5402.91895621566;5409;5414.485623865727;5423;5426.321709786277;5355.169948657965;5404.216388623628;5409.945900540944;5412.296401467784;5413.918791218056;5415.783368665288;5416.322959630046;5418.485243901823;5419.268398766116;5421.945780542223;4119.773412462343;4142.46148000764;4193.559676234013;4227.725197862129;4239.40648309237;3747.2505498900327;3750.287445385368;3751.7748935063983;3767.4160505121204;3770.6417890300377;5185.714785686748;5211.478852114834;5215.6609820361555;5270.947290527122;5318.441563635763;5570.582206334541;5600.719964001783;5656.6888821115235;5706;5714.285714285715;5187.507186817246;5196.740162991835;5200.583953283728;5201.713905735221;5202.375714914235;4735.976320118378;4779.856604301876;4782.641301902371;4783.1390349737385;4831.73425461603;5585.916211256835;5641.294838145232;5646.011947909182;5684.204211410406;5694.088945768657;5550.722463876871;5566.749496272759;5569.693666848362;5571.721413929206;5572.582056345709;5511.338639363142;5691.971540142273;5724.4275572444085;5728.083506638918;5743.052396354555;5421.728913554385;5432.320959880015;5433.809816656398;5436.864078398072;5478.479544443271;5456.290682211287;5486.643368181056;5497.3952865184;5502;5510.779568817203;5303.496167864047;5322.068637988414;5363.329583802025;5400.864978375572;5432.049391356576;5407.648502847303;5417.322834645669;5437.184422336682;5441.945580544144;5462.126059830408;5308.4160742317545;5311.575073993994;5319.281896943863;5321.7073060980465;5368.570514358764;5352.437994010573;5379.4082650907585;5465.316835395575;5480.698561578992;5483.341998960151;5323.973380133075;5326.14781634952;5329.9467005331;5332.813351532678;5389.353277606712 22:41:37 INFO - PROCESS | 19741 | |1;ext.html;599.1881001243315;631.5263552335748;635.0125554762345;637.3435361577571;639.3031595560839;31361.843190784042;32132.518012229837;32177.5173372399;32271.99999999997;38092.238155236875;42248.577514224846;42933.78533107338;43116;43130.35304470435;43140;8423.157684231574;8690.08754080822;8712.303015758724;8720.781980450476;8723.432976856484;8480.448770829908;8621.525816080113;8628.65485380584;8630.093840146788;8636.265917396997;8639.827203455958;8907.287417006657;8931.866022009675;8936.910630893706;8948.776280592972;8806.779830504225;8884.955575222082;8887.555622218895;8893.822123557526;8896.154865287788;8670.306375489945;8780.824383512358;8786.64853405863;8803.64785408583;8806.20744133031;42119;42675;42707.35938960887;42788.35817462741;42819;3586.7847929124073;3683.7605555638797;3875.263699897039;4060.330045542482;4103.548609652936;31654.208644783834;31954.360912781845;33404.164895877555;33476.16309592255;33555.83222083874;4302.806373713191;4346.326319420495;4374.147041326943;4473.597376236122;4512.503624601291;222099;222294;222834.88582557146;222915;224002;56708.71645641745;56988.71505642528;57085;57086.57283567861;57344;60991.695041525396;61122;61306.69346653238;61430;61437.38562614406;14861.405543778345;15001.399944002118;15006.774898376532;15019.549413517612;15041.398344066334;11856.288622682667;11864.703382415508;11913.523459061715;11920.46357913896;11923.926846583849;15211.771823422658;17541.824581754274;17656.646867062842;17669.20488578017;17702.114894255235;5566.860828479321;5829.213056237439;5835.503982161564;5864.266966629171;5947.197128387699;922.6447817590142;981.6711401680517;1061.3260579532052;1083.4853444613746;1188.988110118905;27178.5923211152;28380;28686.282842929093;29146.562801557993;29161;1123.8763735989035;1129.4014172488594;1142.173121524221;1150.2121047082608;1193.9522419103312;16795.32818687239;16938.745918811226;17194;17241.482755517354;17283.222254998556;464117;465887;470900;471811;472006;58414.7079264601;58604.12093818596;58660.706696466244;58687.70656146692;58720;1261.3630116790962;1274.6940734223906;1395.4487977249132;1467.3690313165441;1496.1845794042056;29747.107586771566;31026.379472409975;31285.843570782;31489.370212596077;32122.51816222712;46123.30815037844;46353.53646463492;46582.76708616571;46610.300845486665;46700;228622;228724;229270;229591;229770;31542;37208.44187337246;37773.81113094417;37959.240815184094;37982.43026354662;41314.79342603268;41657.166856662094;41735;42643.78678106714;42753;37849.62150378571;38409;39122.41316380313;39217.21565568616;39612;39155.21689566136;39697.2060558793;39726.2054758909;39818.60181398265;40486.392704108875;35871.82064089663;37154.25691486209;37295.81352093222;38836.41745373765;38875.416868746426;31277;33273.667263328025;33578.83210583931;33719.63962522698;33787;26050.478990419706;26944.191674249803;27028.864855675594;27205.86397068002;27484.58773118365 22:41:37 INFO - PROCESS | 19741 | |2;jquery.html;377.2699825837005;385.2180074448868;390.17478033958184;395.6893838336906;396.1364225987348;17132.743008854875;18779.718304225447;18798.624027519443;18801.059947002628;19290.614187716274;17859.19633616487;17969.281228750868;18464.907675461636;18618.53453663659;18626.161822717975;5471.72641367932;5527.917081243784;5598.776048958037;5642.407547207526;5650.3219613646215;5427.48438898304;5587.497125258726;5624.831255062355;5635.154726790994;5640.5487560995225;5421.701806400646;5554.8611284718;5555.055640541097;5562.833115006556;5565.332160140789;5369.382521010075;5511.338639363262;5541.972290138564;5545.390007099216;5549.861253468655;3898.4542164097047;4924.236743304794;4944.035912996967;4947;4951.653384263103;22408.103675853108;22602.77397226023;22822.88588557063;22909.427264318358;22913.656295155586;2300.861948283108;2311.3759284993125;2327.301809457173;2377.251165882759;2383.5352106339096;13817.447302108005;14332.785008224884;14335.641608959755;14413.13521188732;14565.198914059722;1896.5637903282184;1947.289239427613;2004.518915460279;2019.8283145932614;2050.8974551272377;79368.60315698442;81197;81806;81839.59080204621;82742.58628706817;10190.490475476197;10217.18262538995;10700.678979630624;10748.570057197625;10915.836262456069;14902.031367961048;14979.400823967137;14989.550313490394;14999.475018374305;15008.774868376982;7672.117706463717;7821.960890195626;7841.529508229524;7910.446268761131;7965.322947549407;7377.704891804267;7477.364424024019;7488;7597.620118994028;7614.2766437188375;6623.30455302196;6661.700223489955;6687.762763888599;6704.161979752531;6710.932890671031;1854.4436668999247;1874.3065065925696;1895.8009409011854;1896.838768704648;1908.1127275816812;927.638221093774;1026.5013080901967;1035.6841163445222;1051.673981065872;1082.2478377527543;18980.62038759217;19037;19592.70610940837;19635.705464418046;19696.70454943177;1028.2236911132047;1055.5039131608132;1058.3385384134915;1066.3495267886583;1069.2141276162015;10837.83743243852;11247.381394023243;11264.54941802335;11303.773924521463;11381.943090284662;471487;476160;482715;485276;487795.2933059411;81365;82017.17982820095;82048.17951820405;82115.5894220537;82361.17638823655;1003.844404117363;1049.35989046683;1050.406520316019;1062.5537274344795;1062.6493257225097;16319.020858748512;16667.333306668083;16962.66074678524;16990.49028529146;17742.91128544349;36835;37620.62379376171;38774.80612596919;40134.397984030846;40306.395404068375;48320;49417.50582494129;52329;54178.45821541734;54385.72807135939;8219.83560328802;8368.121347258693;8402.537860417735;8547.487150770974;8628.439151455135;11513.654590362303;13271.535496257584;13417.865821342051;13425.798613020617;13601.523946661819;11394.088472922313;11859.881401185878;11963.880361196625;11975.64073077809;12020.33888136126;11797.941010294893;11830.11274154459;11844.881551184722;11863;11930.164888457724;11719.472623731783;11724.648260552198;11849.763004740029;12010.699732506408;12400.503979840705;7899.723509677134;8055.033395992518;8061.072976607765;8383.245507904317;8509.74470765878;8351.874721879056;10796.329584676487;11303.71740706456;11401.916817902285;11524.59663911759 22:41:37 INFO - PROCESS | 19741 | |3;mootools.html;1305.5104335874048;1459.7883306920496;1476.1954734669605;1583.216307927576;1727.9222434990425;7514.887276690847;7898.210178982099;7912.485688430248;7913;7916.485428447147;7644.885326720104;7826.8043298917555;7836.843263134734;7842.333401660851;7847.058352997634;2135.220644464771;2161.5352699169753;2164.3723320237114;2164.3831508020216;2164.4805246740825;2092.4978005278776;2104;2161.729783777028;2171.446281198292;2172.9022194001227;2100.1179504608026;2114.312848324293;2117.449463139587;2120.5652841167603;2157.331227319536;2101.3380785052736;2106.273335699181;2108.736407949006;2108.778578249277;2114.1332053858;2007.4579863436936;2055.537504061574;2066.6693329067275;2067.886266255355;2076.0553947953795;7616.124145723257;7874.803129921798;7889.684412623488;7970.760877173694;7983.481073730247;4533.863984080483;4671.229247174212;4682.180618391768;4690;4701.7414042227665;3079.3995170941675;3119.6412412572618;3167.33485967947;3183.060997005889;3201.399300349825;984.9015098490165;996.5366104761321;1009.8535712321745;1013.989860101397;1026.8819085805153;10781.137508999262;10988.340699557972;10993.34039957597;10998.725031874186;11018;4168.708190426702;4214.683898707548;4281.892952676208;4306.913861722748;4309.310510318334;9378.67174648884;9453.952730236442;9481.525923703788;9486.383385079947;9487.66793162236;4789.401324834395;4808.3027960946165;4816.109019831272;4820.6143508519235;4821.421429428421;3698.2973235085246;3807.58116607173;4259.254630439661;4365.257906155961;4411.426514553087;3730.813459327023;3766.7174961877968;3809.12390150267;3814.561325447609;3847;1139.145640769423;1146.5585749486509;1156.6876943225282;1156.7975604269388;1161.1581603337513;873.0527377795163;914.9313801464783;942.9387089839139;948.0803620488116;966.1449617088787;5529.751161197756;5567.66594004361;5669.574781891292;5872.060470324813;5879.323877754027;891.8483857744199;922.5295099499303;929.0477260807726;970.9271804614682;979.1725991537139;3802.6387493188104;4030.7783071931326;4080.2859499587453;4097.713160078825;4113.197926404382;9613.279004074722;9956.950215249022;10007.599696012077;10047.748806279755;10065.446400448045;9755.219582433388;9766.36518626287;9879.506024698736;9882.11061004513;9930.652427165014;7571.167171611119;7649.617519124022;7663.540187588763;7684.46208765381;7747.767566973;5534;5622.606417550732;5679.290088738908;5736.885262294647;5786.508146807569;8710.564471776259;8843.823123537364;8956.28349732033;9034.593443294936;9039.096090390909;8739.169778870997;9109.453432794053;9122.315826313186;9123.589438475152;9161.679341223025;6349.460295874902;6514.055461958084;6647.567908085959;6844.4182244509775;6861.691223894837;7205.279472052753;7210.9278907210255;7218.458615603956;7250;7282.417406607353;6559.27847936717;6576.506761992774;6631.403173714389;6658.201015878126;6793.490488213305;6623.3376662333385;6694;6713.227978782503;6719.865602687821;6762.087118239171;5934.643921364732;6061.9393806063135;6306.905396419149;6314.494840412848;6371.585846920121;4566.2237419639405;4578;4766.976165119152;4932.605391568594;4991.900161996812;4884.5603895649565;5012.248162775612;5093.617978651542;5153.201253805666;5212.687238765686 22:41:37 INFO - PROCESS | 19741 | |4;prototype.html;285.4277174265597;286.40285005762985;286.9713028697132;287.8474408563462;289.41682509742867;5153.407358153813;5188.184135552559;5212.582993360532;5235.764390602422;5237.554807841333;5177.378714554249;5180.093483640358;5187.9740601297035;5192.766325515351;5214.374275086985;3787.280416720821;3842.5773164951834;3961.187956468917;3978.9204215915665;3993.3011722948513;3947.3486874665646;3951.6443520083185;3955.624215699504;3968.503937007874;3990.481237439129;3756.248750249947;3901.765894046366;3941.1723538057045;3945.9408108878247;3968.7420317679403;3827.311084004878;3917.5103112110987;3925.0187453136714;3944.8816535504125;3965.266425711253;3442.6729460701195;3443.5867695876404;3454.222799870009;3456.5333679953387;3482.355764183634;5021.121303771862;5022.54797068262;5023.899522009539;5029.3964724232965;5034.3455350804525;4283.742975421454;4497.460304763449;4504.572065653758;4545.681802273843;4566.703164294344;5352.625316227865;5366.91949620756;5394.541463975567;5405.594580406446;5425.701586412746;3803.8858834235016;3806.3148633246283;3809.6190380961957;3816.2367526494536;3822.4648549203134;5524.889502209933;5610.513213998293;5634.915476267859;5645.350784659776;5685.40303268155;3866.188100498927;3872.3997780344093;3884.669803066771;3884.7474914131058;3893.922121557553;3923.1172986077904;3925.156091440354;3925.941110883339;3942.3692209246383;3960.2277555876904;4391.253486907233;4527.253003254426;4534.659900507475;4539.818407263672;4554.95445045552;5428.37573679032;5438.7280635968045;5439.782408703608;5440.102383106743;5488.890222195534;1408.8943329250142;1421.175718083509;1427.307755738466;1428.3929330034694;1432.2767002663797;876.8027193881453;926.4395041000232;928.7724507495572;952.5332587032443;960.2366118935323;5558.749856256478;5575.776968921197;5601.29983752031;5607.214989901417;5622.718864056863;5943.5839491236065;5946.256717910262;5963.642181469126;5969.701514924236;5993.130996005555;5385.542228910508;5533.22534845122;5575.689712917461;5594.468525490072;5616.775328986876;3123.9062828115193;3147.62228532573;3150.7951983121025;3154.274516861135;3166.667499912522;5973.402659734079;6062.969685151546;6078.848028799315;6087.543434242361;6095.847603809941;5946.524278057745;5999.5800293979;6004.4088316596135;6016.097585362143;6042.848928776816;6021.5182785377065;6043.123747056652;6054.66699331541;6071.3928607139815;6091.817245482643;5379.1662292344745;5662.235598194191;5693.551772737763;5709.486146246858;5709.9714501427225;5600.831975040755;5615.831525054255;5621.437856214346;5631.380548139619;5632.352279487911;5648.661080335193;5806.796762113306;5833.387494313036;5860.271219990028;5871.6770577618645;3755.286495565834;3782.829772660292;3791.0711875590655;3814.27528769544;3820.541535015816;5679.772809087755;5709.457601527848;5714.742836572281;5734.483896449339;5740.6268592541355;5429.267048948342;5449.509544141047;5484.61607687458;5528.751206195811;5531.9723401382735;5457.508824205841;5465.070937940639;5508.779648814163;5519.31008623922;5547.613096725819;5113.386393632788;5159.509846564571;5261.421243663271;5358.33020872391;5411.78352865881;5490.81947381315;5520.66875987442;5524.226608274765;5539.612227144223;5549.778008879761;5426.620136590401;5446.700431476307;5458.2904222450825;5458.727063646881;5489.313835770528 22:41:37 INFO - PROCESS | 19741 | |5;yui.html;605.2071785960392;758.9658465369058;765.1736124985017;768.1818862910998;779.0884664942017;12816.23102613844;13133.605991820237;13198.076134670577;13227.867721322784;13230.735385292288;12427.502899884017;12476.438560264787;12476.563320283793;12489.12576119672;12489.687757806038;673.9561928474634;793.7499687598416;807.733447962174;817.1011886924395;817.2807929022451;800.7077416742876;810.7648781853255;810.9716159934403;811.2739098506833;811.663159788687;856.3834039491556;864.6714248585529;866.0084203586889;866.5234121233328;867.1675191815864;711.9537230080028;827.9379046571471;848.3171047306915;854.8204876975842;859.7506723050308;628.0673200297555;628.8899442597573;629.0155906007084;629.7732816186169;630.9905351419733;12708.173968692097;12735.872641273561;12747.745045099138;12755.298458584773;12768.425420856083;12543.749125017539;13022.218666879922;13072.215667060007;13094.47622095115;13259.734805303937;10727.409992450412;10739.400593916134;10850.348979061282;10931.070858976997;11186.384748838811;3688.520492336006;3731.5708693500324;3743.9438408423894;3753.230587729509;3781.6785573226307;51941.48058519442;52057.479425205645;54382.456175438136;55272;55405.72297138489;9960.80078398428;9993.950030249802;10042;10067.647632332833;10206.591736330613;16431.096289704183;16466.75299870503;16516;16559.586010349598;16589.336426542803;7995.800104997305;8020.35837133028;8166.305864001508;8238.052623948202;8363.749087527383;4644.814207431732;4657.083700702409;4674.439067311944;4771.021940502189;4830.541098595628;3154.794938329001;3247.253131779704;3257.641659417462;3259.869605215812;3265.706086452183;547.1082136118102;562.3083607163212;564.9576531299746;569.4931510955253;579.7767859374171;580.7822066724979;597.7160848596882;614.9631022138686;648.5784240243785;708.861771954464;8234.917650823534;8942.329325300629;8946.552672366355;8957.641694332284;9147.634094636272;690.1200968764765;699.2902204262678;702.4766548921086;713.9464540159508;716.6488420673833;4038.5355684096116;4183.3967709032895;4260.914781704349;4289.592488713567;4383.662982790216;60243;61736.69131654403;62049.68975155186;62470.68764656239;62511.68744156341;54685.72657136768;55262.447375526535;55615.44384556184;56096;56893;47731.28403073957;48165.5183448168;48282.758586206844;48360;50119.74940125349;8550.187732165434;8643.17889800468;8663;8701.825963480822;8845.646174152962;32968.34063318768;33218.66781332156;33282.33435331231;33923.83038084794;34631.82684086664;42113.57886421219;43269.78365108154;43337.78331108324;44248.77875610601;45194.54805451904;11753.236039657395;11855.52577896909;11877.76244475123;11971.341576213392;12001.879981200076;12872.420741066862;12945.28800915921;12956.481740730265;13034.804477932648;13241;12070.45682944252;12086.818697719365;12113.69715757113;12468.251904885736;12771.042171836963;11851.644450666494;12048.638540843789;12053.81919271194;12138;12296.815547766611;11932.105092117952;11963.282203067844;11963.581274655346;12011.75976480448;12030.63908082759;9892.520399138575;10107.747306317107;10302.536385862804;10508.054275115277;10565.207609429477;9695.660651877433;10051.849222261819;10187.592496300065;10227.84658230142;10242.436665983443 22:41:37 INFO - PROCESS | 19741 | __end_tp_report 22:41:37 INFO - PROCESS | 19741 | __start_cc_report 22:41:37 INFO - PROCESS | 19741 | _x_x_mozilla_cycle_collect,980 22:41:37 INFO - PROCESS | 19741 | __end_cc_report 22:41:37 INFO - PROCESS | 19741 | __startTimestamp1462254097756__endTimestamp 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | ------- Summary: start ------- 22:41:37 INFO - PROCESS | 19741 | Number of tests: 6 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#0] dojo.html Cycles:165 Average:5127.09 Median:5323.97 stddev:558.49 (10.5%) stddev-sans-first:535.70 22:41:37 INFO - PROCESS | 19741 | Values: 3041.4 3078.4 3125.8 3135.2 3165.9 5057.1 5117.6 5172.8 5180.4 5218.3 5157.4 5192.6 5218.3 5244.2 5288.8 4681.0 4724.1 4729.8 4790.6 4869.8 4767.0 4832.7 4834.3 4837.3 4863.6 4640.8 4658.0 4663.3 4736.3 4803.4 4712.3 4737.1 4748.6 4749.6 4793.7 4636.9 4651.1 4655.6 4666.7 4699.9 5051.6 5069.3 5106.2 5209.9 5224.0 5437.1 5465.7 5482.6 5489.8 5495.6 5484.1 5496.4 5497.6 5499.1 5502.8 5071.2 5089.6 5116.9 5190.5 5193.1 5628.3 5631.5 5634.5 5636.0 5670.7 5250.3 5384.7 5407.9 5414.9 5415.3 5402.9 5409.0 5414.5 5423.0 5426.3 5355.2 5404.2 5409.9 5412.3 5413.9 5415.8 5416.3 5418.5 5419.3 5421.9 4119.8 4142.5 4193.6 4227.7 4239.4 3747.3 3750.3 3751.8 3767.4 3770.6 5185.7 5211.5 5215.7 5270.9 5318.4 5570.6 5600.7 5656.7 5706.0 5714.3 5187.5 5196.7 5200.6 5201.7 5202.4 4736.0 4779.9 4782.6 4783.1 4831.7 5585.9 5641.3 5646.0 5684.2 5694.1 5550.7 5566.7 5569.7 5571.7 5572.6 5511.3 5692.0 5724.4 5728.1 5743.1 5421.7 5432.3 5433.8 5436.9 5478.5 5456.3 5486.6 5497.4 5502.0 5510.8 5303.5 5322.1 5363.3 5400.9 5432.0 5407.6 5417.3 5437.2 5441.9 5462.1 5308.4 5311.6 5319.3 5321.7 5368.6 5352.4 5379.4 5465.3 5480.7 5483.3 5324.0 5326.1 5329.9 5332.8 5389.4 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#1] ext.html Cycles:180 Average:48153.89 Median:39414.61 stddev:86796.13 (220.2%) stddev-sans-first:86966.18 22:41:37 INFO - PROCESS | 19741 | Values: 599.2 631.5 635.0 637.3 639.3 31361.8 32132.5 32177.5 32272.0 38092.2 42248.6 42933.8 43116.0 43130.4 43140.0 8423.2 8690.1 8712.3 8720.8 8723.4 8480.4 8621.5 8628.7 8630.1 8636.3 8639.8 8907.3 8931.9 8936.9 8948.8 8806.8 8885.0 8887.6 8893.8 8896.2 8670.3 8780.8 8786.6 8803.6 8806.2 42119.0 42675.0 42707.4 42788.4 42819.0 3586.8 3683.8 3875.3 4060.3 4103.5 31654.2 31954.4 33404.2 33476.2 33555.8 4302.8 4346.3 4374.1 4473.6 4512.5 222099.0 222294.0 222834.9 222915.0 224002.0 56708.7 56988.7 57085.0 57086.6 57344.0 60991.7 61122.0 61306.7 61430.0 61437.4 14861.4 15001.4 15006.8 15019.5 15041.4 11856.3 11864.7 11913.5 11920.5 11923.9 15211.8 17541.8 17656.6 17669.2 17702.1 5566.9 5829.2 5835.5 5864.3 5947.2 922.6 981.7 1061.3 1083.5 1189.0 27178.6 28380.0 28686.3 29146.6 29161.0 1123.9 1129.4 1142.2 1150.2 1194.0 16795.3 16938.7 17194.0 17241.5 17283.2 464117.0 465887.0 470900.0 471811.0 472006.0 58414.7 58604.1 58660.7 58687.7 58720.0 1261.4 1274.7 1395.4 1467.4 1496.2 29747.1 31026.4 31285.8 31489.4 32122.5 46123.3 46353.5 46582.8 46610.3 46700.0 228622.0 228724.0 229270.0 229591.0 229770.0 31542.0 37208.4 37773.8 37959.2 37982.4 41314.8 41657.2 41735.0 42643.8 42753.0 37849.6 38409.0 39122.4 39217.2 39612.0 39155.2 39697.2 39726.2 39818.6 40486.4 35871.8 37154.3 37295.8 38836.4 38875.4 31277.0 33273.7 33578.8 33719.6 33787.0 26050.5 26944.2 27028.9 27205.9 27484.6 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#2] jquery.html Cycles:180 Average:28225.93 Median:22866.16 stddev:79038.13 (345.7%) stddev-sans-first:79232.19 22:41:37 INFO - PROCESS | 19741 | Values: 377.3 385.2 390.2 395.7 396.1 17132.7 18779.7 18798.6 18801.1 19290.6 17859.2 17969.3 18464.9 18618.5 18626.2 5471.7 5527.9 5598.8 5642.4 5650.3 5427.5 5587.5 5624.8 5635.2 5640.5 5421.7 5554.9 5555.1 5562.8 5565.3 5369.4 5511.3 5542.0 5545.4 5549.9 3898.5 4924.2 4944.0 4947.0 4951.7 22408.1 22602.8 22822.9 22909.4 22913.7 2300.9 2311.4 2327.3 2377.3 2383.5 13817.4 14332.8 14335.6 14413.1 14565.2 1896.6 1947.3 2004.5 2019.8 2050.9 79368.6 81197.0 81806.0 81839.6 82742.6 10190.5 10217.2 10700.7 10748.6 10915.8 14902.0 14979.4 14989.6 14999.5 15008.8 7672.1 7822.0 7841.5 7910.4 7965.3 7377.7 7477.4 7488.0 7597.6 7614.3 6623.3 6661.7 6687.8 6704.2 6710.9 1854.4 1874.3 1895.8 1896.8 1908.1 927.6 1026.5 1035.7 1051.7 1082.2 18980.6 19037.0 19592.7 19635.7 19696.7 1028.2 1055.5 1058.3 1066.3 1069.2 10837.8 11247.4 11264.5 11303.8 11381.9 471487.0 476160.0 482715.0 485276.0 487795.3 81365.0 82017.2 82048.2 82115.6 82361.2 1003.8 1049.4 1050.4 1062.6 1062.6 16319.0 16667.3 16962.7 16990.5 17742.9 36835.0 37620.6 38774.8 40134.4 40306.4 48320.0 49417.5 52329.0 54178.5 54385.7 8219.8 8368.1 8402.5 8547.5 8628.4 11513.7 13271.5 13417.9 13425.8 13601.5 11394.1 11859.9 11963.9 11975.6 12020.3 11797.9 11830.1 11844.9 11863.0 11930.2 11719.5 11724.6 11849.8 12010.7 12400.5 7899.7 8055.0 8061.1 8383.2 8509.7 8351.9 10796.3 11303.7 11401.9 11524.6 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#3] mootools.html Cycles:180 Average:5246.63 Median:5371.22 stddev:2918.67 (54.3%) stddev-sans-first:2911.83 22:41:37 INFO - PROCESS | 19741 | Values: 1305.5 1459.8 1476.2 1583.2 1727.9 7514.9 7898.2 7912.5 7913.0 7916.5 7644.9 7826.8 7836.8 7842.3 7847.1 2135.2 2161.5 2164.4 2164.4 2164.5 2092.5 2104.0 2161.7 2171.4 2172.9 2100.1 2114.3 2117.4 2120.6 2157.3 2101.3 2106.3 2108.7 2108.8 2114.1 2007.5 2055.5 2066.7 2067.9 2076.1 7616.1 7874.8 7889.7 7970.8 7983.5 4533.9 4671.2 4682.2 4690.0 4701.7 3079.4 3119.6 3167.3 3183.1 3201.4 984.9 996.5 1009.9 1014.0 1026.9 10781.1 10988.3 10993.3 10998.7 11018.0 4168.7 4214.7 4281.9 4306.9 4309.3 9378.7 9454.0 9481.5 9486.4 9487.7 4789.4 4808.3 4816.1 4820.6 4821.4 3698.3 3807.6 4259.3 4365.3 4411.4 3730.8 3766.7 3809.1 3814.6 3847.0 1139.1 1146.6 1156.7 1156.8 1161.2 873.1 914.9 942.9 948.1 966.1 5529.8 5567.7 5669.6 5872.1 5879.3 891.8 922.5 929.0 970.9 979.2 3802.6 4030.8 4080.3 4097.7 4113.2 9613.3 9957.0 10007.6 10047.7 10065.4 9755.2 9766.4 9879.5 9882.1 9930.7 7571.2 7649.6 7663.5 7684.5 7747.8 5534.0 5622.6 5679.3 5736.9 5786.5 8710.6 8843.8 8956.3 9034.6 9039.1 8739.2 9109.5 9122.3 9123.6 9161.7 6349.5 6514.1 6647.6 6844.4 6861.7 7205.3 7210.9 7218.5 7250.0 7282.4 6559.3 6576.5 6631.4 6658.2 6793.5 6623.3 6694.0 6713.2 6719.9 6762.1 5934.6 6061.9 6306.9 6314.5 6371.6 4566.2 4578.0 4767.0 4932.6 4991.9 4884.6 5012.2 5093.6 5153.2 5212.7 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#4] prototype.html Cycles:180 Average:4623.33 Median:5373.04 stddev:1412.04 (26.3%) stddev-sans-first:1377.95 22:41:37 INFO - PROCESS | 19741 | Values: 285.4 286.4 287.0 287.8 289.4 5153.4 5188.2 5212.6 5235.8 5237.6 5177.4 5180.1 5188.0 5192.8 5214.4 3787.3 3842.6 3961.2 3978.9 3993.3 3947.3 3951.6 3955.6 3968.5 3990.5 3756.2 3901.8 3941.2 3945.9 3968.7 3827.3 3917.5 3925.0 3944.9 3965.3 3442.7 3443.6 3454.2 3456.5 3482.4 5021.1 5022.5 5023.9 5029.4 5034.3 4283.7 4497.5 4504.6 4545.7 4566.7 5352.6 5366.9 5394.5 5405.6 5425.7 3803.9 3806.3 3809.6 3816.2 3822.5 5524.9 5610.5 5634.9 5645.4 5685.4 3866.2 3872.4 3884.7 3884.7 3893.9 3923.1 3925.2 3925.9 3942.4 3960.2 4391.3 4527.3 4534.7 4539.8 4555.0 5428.4 5438.7 5439.8 5440.1 5488.9 1408.9 1421.2 1427.3 1428.4 1432.3 876.8 926.4 928.8 952.5 960.2 5558.7 5575.8 5601.3 5607.2 5622.7 5943.6 5946.3 5963.6 5969.7 5993.1 5385.5 5533.2 5575.7 5594.5 5616.8 3123.9 3147.6 3150.8 3154.3 3166.7 5973.4 6063.0 6078.8 6087.5 6095.8 5946.5 5999.6 6004.4 6016.1 6042.8 6021.5 6043.1 6054.7 6071.4 6091.8 5379.2 5662.2 5693.6 5709.5 5710.0 5600.8 5615.8 5621.4 5631.4 5632.4 5648.7 5806.8 5833.4 5860.3 5871.7 3755.3 3782.8 3791.1 3814.3 3820.5 5679.8 5709.5 5714.7 5734.5 5740.6 5429.3 5449.5 5484.6 5528.8 5532.0 5457.5 5465.1 5508.8 5519.3 5547.6 5113.4 5159.5 5261.4 5358.3 5411.8 5490.8 5520.7 5524.2 5539.6 5549.8 5426.6 5446.7 5458.3 5458.7 5489.3 22:41:37 INFO - PROCESS | 19741 | 22:41:37 INFO - PROCESS | 19741 | [#5] yui.html Cycles:180 Average:14323.56 Median:24919.68 stddev:16901.94 (67.8%) stddev-sans-first:16917.96 22:41:37 INFO - PROCESS | 19741 | Values: 605.2 759.0 765.2 768.2 779.1 12816.2 13133.6 13198.1 13227.9 13230.7 12427.5 12476.4 12476.6 12489.1 12489.7 674.0 793.7 807.7 817.1 817.3 800.7 810.8 811.0 811.3 811.7 856.4 864.7 866.0 866.5 867.2 712.0 827.9 848.3 854.8 859.8 628.1 628.9 629.0 629.8 631.0 12708.2 12735.9 12747.7 12755.3 12768.4 12543.7 13022.2 13072.2 13094.5 13259.7 10727.4 10739.4 10850.3 10931.1 11186.4 3688.5 3731.6 3743.9 3753.2 3781.7 51941.5 52057.5 54382.5 55272.0 55405.7 9960.8 9994.0 10042.0 10067.6 10206.6 16431.1 16466.8 16516.0 16559.6 16589.3 7995.8 8020.4 8166.3 8238.1 8363.7 4644.8 4657.1 4674.4 4771.0 4830.5 3154.8 3247.3 3257.6 3259.9 3265.7 547.1 562.3 565.0 569.5 579.8 580.8 597.7 615.0 648.6 708.9 8234.9 8942.3 8946.6 8957.6 9147.6 690.1 699.3 702.5 713.9 716.6 4038.5 4183.4 4260.9 4289.6 4383.7 60243.0 61736.7 62049.7 62470.7 62511.7 54685.7 55262.4 55615.4 56096.0 56893.0 47731.3 48165.5 48282.8 48360.0 50119.7 8550.2 8643.2 8663.0 8701.8 8845.6 32968.3 33218.7 33282.3 33923.8 34631.8 42113.6 43269.8 43337.8 44248.8 45194.5 11753.2 11855.5 11877.8 11971.3 12001.9 12872.4 12945.3 12956.5 13034.8 13241.0 12070.5 12086.8 12113.7 12468.3 12771.0 11851.6 12048.6 12053.8 12138.0 12296.8 11932.1 11963.3 11963.6 12011.8 12030.6 9892.5 10107.7 10302.5 10508.1 10565.2 9695.7 10051.8 10187.6 10227.8 10242.4 22:41:37 INFO - PROCESS | 19741 | -------- Summary: end -------- 22:41:37 INFO - PROCESS | 19741 | 22:41:38 INFO - TEST-INFO | 19741: exit 0 22:41:38 INFO - TEST-OK | dromaeo_css | took 1111794ms 22:41:38 INFO - TEST-START | kraken 22:41:38 INFO - operating with platform_type : linux_ 22:41:38 INFO - Initialising browser for kraken test... 22:41:38 INFO - TEST-INFO | started process 19922 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ymYZl/profile http://localhost:51241/getInfo.html) 22:41:42 INFO - PROCESS | 19922 | __metrics Screen width/height:1600/1200 22:41:42 INFO - PROCESS | 19922 | colorDepth:24 22:41:42 INFO - PROCESS | 19922 | Browser inner width/height: 1024/697 22:41:42 INFO - PROCESS | 19922 | __metrics 22:41:43 ERROR - PROCESS | 19922 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:41:44 INFO - TEST-INFO | 19922: exit 0 22:41:44 INFO - Browser initialized. 22:41:44 INFO - Running cycle 1/1 for kraken test... 22:41:44 INFO - TEST-INFO | started process 20005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ymYZl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:56 INFO - PROCESS | 20005 | RSS: Main: 154976256 22:41:56 INFO - PROCESS | 20005 | 22:41:58 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51241/tests/kraken/driver.html?testName=audio-beat-detection) 22:41:59 INFO - PROCESS | 20005 | RSS: Main: 209645568 22:41:59 INFO - PROCESS | 20005 | 22:42:02 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51241/tests/kraken/driver.html?testName=audio-dft) 22:42:03 INFO - PROCESS | 20005 | RSS: Main: 196468736 22:42:03 INFO - PROCESS | 20005 | 22:42:06 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51241/tests/kraken/driver.html?testName=audio-fft) 22:42:06 INFO - PROCESS | 20005 | RSS: Main: 265310208 22:42:06 INFO - PROCESS | 20005 | 22:42:08 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51241/tests/kraken/driver.html?testName=audio-oscillator) 22:42:09 INFO - PROCESS | 20005 | RSS: Main: 174395392 22:42:09 INFO - PROCESS | 20005 | 22:42:11 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:12 INFO - PROCESS | 20005 | RSS: Main: 179892224 22:42:12 INFO - PROCESS | 20005 | 22:42:15 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51241/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:15 INFO - PROCESS | 20005 | RSS: Main: 215523328 22:42:15 INFO - PROCESS | 20005 | 22:42:19 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51241/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:19 INFO - PROCESS | 20005 | RSS: Main: 215994368 22:42:19 INFO - PROCESS | 20005 | 22:42:22 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51241/tests/kraken/driver.html?testName=json-parse-financial) 22:42:23 INFO - PROCESS | 20005 | RSS: Main: 216027136 22:42:23 INFO - PROCESS | 20005 | 22:42:24 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:25 INFO - PROCESS | 20005 | RSS: Main: 203255808 22:42:25 INFO - PROCESS | 20005 | 22:42:27 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:27 INFO - PROCESS | 20005 | RSS: Main: 205910016 22:42:27 INFO - PROCESS | 20005 | 22:42:29 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:30 INFO - PROCESS | 20005 | RSS: Main: 217370624 22:42:30 INFO - PROCESS | 20005 | 22:42:32 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:42:33 INFO - PROCESS | 20005 | RSS: Main: 224174080 22:42:33 INFO - PROCESS | 20005 | 22:42:36 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:42:36 INFO - PROCESS | 20005 | RSS: Main: 220868608 22:42:36 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | Cycle 1(1): loaded http://localhost:51241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51241/tests/kraken/driver.html?testName=ai-astar) 22:42:38 INFO - PROCESS | 20005 | RSS: Main: 285396992 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | __start_tp_report 22:42:38 INFO - PROCESS | 20005 | _x_x_mozilla_page_load 22:42:38 INFO - PROCESS | 20005 | _x_x_mozilla_page_load_details 22:42:38 INFO - PROCESS | 20005 | |i|pagename|runs| 22:42:38 INFO - PROCESS | 20005 | |0;ai-astar;111;111;106;110;112;113;102;111;112;111 22:42:38 INFO - PROCESS | 20005 | |1;audio-beat-detection;161;127;154;189;129;155;157;129;181;129 22:42:38 INFO - PROCESS | 20005 | |2;audio-dft;161;161;161;163;161;162;161;162;161;161 22:42:38 INFO - PROCESS | 20005 | |3;audio-fft;74;77;114;107;74;75;75;128;104;75 22:42:38 INFO - PROCESS | 20005 | |4;audio-oscillator;94;94;154;95;93;94;153;94;94;161 22:42:38 INFO - PROCESS | 20005 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;117 22:42:38 INFO - PROCESS | 20005 | |6;imaging-darkroom;145;145;145;145;145;145;145;146;146;146 22:42:38 INFO - PROCESS | 20005 | |7;imaging-desaturate;94;95;94;95;94;95;95;95;95;94 22:42:38 INFO - PROCESS | 20005 | |8;json-parse-financial;57;56;59;56;57;57;58;83;58;53 22:42:38 INFO - PROCESS | 20005 | |9;json-stringify-tinderbox;62;62;61;62;63;72;62;62;61;62 22:42:38 INFO - PROCESS | 20005 | |10;stanford-crypto-aes;80;76;77;78;79;79;78;87;79;78 22:42:38 INFO - PROCESS | 20005 | |11;stanford-crypto-ccm;130;127;124;125;123;121;128;128;158;125 22:42:38 INFO - PROCESS | 20005 | |12;stanford-crypto-pbkdf2;170;170;181;170;171;168;172;168;169;168 22:42:38 INFO - PROCESS | 20005 | |13;stanford-crypto-sha256-iterative;70;73;70;71;70;70;69;69;70;70 22:42:38 INFO - PROCESS | 20005 | __end_tp_report 22:42:38 INFO - PROCESS | 20005 | __start_cc_report 22:42:38 INFO - PROCESS | 20005 | _x_x_mozilla_cycle_collect,1664 22:42:38 INFO - PROCESS | 20005 | __end_cc_report 22:42:38 INFO - PROCESS | 20005 | __startTimestamp1462254158974__endTimestamp 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | ------- Summary: start ------- 22:42:38 INFO - PROCESS | 20005 | Number of tests: 14 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:3.53 22:42:38 INFO - PROCESS | 20005 | Values: 111.0 111.0 106.0 110.0 112.0 113.0 102.0 111.0 112.0 111.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:156.00 stddev:22.44 (14.4%) stddev-sans-first:23.52 22:42:38 INFO - PROCESS | 20005 | Values: 161.0 127.0 154.0 189.0 129.0 155.0 157.0 129.0 181.0 129.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 22:42:38 INFO - PROCESS | 20005 | Values: 161.0 161.0 161.0 163.0 161.0 162.0 161.0 162.0 161.0 161.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#3] audio-fft Cycles:10 Average:90.30 Median:74.50 stddev:20.71 (27.8%) stddev-sans-first:21.11 22:42:38 INFO - PROCESS | 20005 | Values: 74.0 77.0 114.0 107.0 74.0 75.0 75.0 128.0 104.0 75.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#4] audio-oscillator Cycles:10 Average:112.60 Median:94.00 stddev:30.02 (31.9%) stddev-sans-first:31.08 22:42:38 INFO - PROCESS | 20005 | Values: 94.0 94.0 154.0 95.0 93.0 94.0 153.0 94.0 94.0 161.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:42:38 INFO - PROCESS | 20005 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:42:38 INFO - PROCESS | 20005 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:42:38 INFO - PROCESS | 20005 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:57.50 stddev:8.45 (14.7%) stddev-sans-first:8.92 22:42:38 INFO - PROCESS | 20005 | Values: 57.0 56.0 59.0 56.0 57.0 57.0 58.0 83.0 58.0 53.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.00 stddev:3.25 (5.2%) stddev-sans-first:3.43 22:42:38 INFO - PROCESS | 20005 | Values: 62.0 62.0 61.0 62.0 63.0 72.0 62.0 62.0 61.0 62.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:3.00 (3.8%) stddev-sans-first:3.16 22:42:38 INFO - PROCESS | 20005 | Values: 80.0 76.0 77.0 78.0 79.0 79.0 78.0 87.0 79.0 78.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.50 stddev:10.57 (8.3%) stddev-sans-first:11.20 22:42:38 INFO - PROCESS | 20005 | Values: 130.0 127.0 124.0 125.0 123.0 121.0 128.0 128.0 158.0 125.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.00 stddev:3.86 (2.3%) stddev-sans-first:4.09 22:42:38 INFO - PROCESS | 20005 | Values: 170.0 170.0 181.0 170.0 171.0 168.0 172.0 168.0 169.0 168.0 22:42:38 INFO - PROCESS | 20005 | 22:42:38 INFO - PROCESS | 20005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.20 22:42:38 INFO - PROCESS | 20005 | Values: 70.0 73.0 70.0 71.0 70.0 70.0 69.0 69.0 70.0 70.0 22:42:38 INFO - PROCESS | 20005 | -------- Summary: end -------- 22:42:38 INFO - PROCESS | 20005 | 22:42:39 INFO - TEST-INFO | 20005: exit 0 22:42:39 INFO - TEST-OK | kraken | took 61473ms 22:42:39 INFO - SUITE-END | took 1173s 22:42:40 INFO - Completed test suite (00:19:33) 22:42:40 INFO - javascript benchmark 22:42:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3041.361314124034, 3078.39971205615, 3125.7655675824317, 3135.2161959510136, 3165.873365065398, 5057.140286151354, 5117.641765076446, 5172.844814655562, 5180.430152683207, 5218.347706536683, 5157.406898206707, 5192.584593232542, 5218.32161818963, 5244.239585260135, 5288.762005709743, 4680.976595117019, 4724.078804633098, 4729.834455794031, 4790.568848803607, 4869.805207791702, 4766.952330476685, 4832.71003739775, 4834.347363105989, 4837.250226214942, 4863.5865951394, 4640.79116439761, 4657.976710116462, 4663.323818046399, 4736.265878788793, 4803.423589169287, 4712.269598212282, 4737.052589482083, 4748.57262846342, 4749.62003039756, 4793.71237725734, 4636.86089417318, 4651.093036857814, 4655.604273636745, 4666.673332866701, 4699.906001879977, 5051.570616497602, 5069.264956581275, 5106.234064890259, 5209.947900520984, 5224.0, 5437.13005919051, 5465.699386533739, 5482.643628164196, 5489.835304940858, 5495.587830912697, 5484.067708489566, 5496.422875598045, 5497.642653227527, 5499.065158922993, 5502.752376143083, 5071.2139618359215, 5089.618278629117, 5116.897662046738, 5190.506901844356, 5193.143131383317, 5628.2683251177905, 5631.493165615114, 5634.492895639412, 5635.971820140873, 5670.744816483269, 5250.291210686509, 5384.730763461811, 5407.864803379868, 5414.945850541523, 5415.296011518478, 5402.91895621566, 5409.0, 5414.485623865727, 5423.0, 5426.321709786277, 5355.169948657965, 5404.216388623628, 5409.945900540944, 5412.296401467784, 5413.918791218056, 5415.783368665288, 5416.322959630046, 5418.485243901823, 5419.268398766116, 5421.945780542223, 4119.773412462343, 4142.46148000764, 4193.559676234013, 4227.725197862129, 4239.40648309237, 3747.2505498900327, 3750.287445385368, 3751.7748935063983, 3767.4160505121204, 3770.6417890300377, 5185.714785686748, 5211.478852114834, 5215.6609820361555, 5270.947290527122, 5318.441563635763, 5570.582206334541, 5600.719964001783, 5656.6888821115235, 5706.0, 5714.285714285715, 5187.507186817246, 5196.740162991835, 5200.583953283728, 5201.713905735221, 5202.375714914235, 4735.976320118378, 4779.856604301876, 4782.641301902371, 4783.1390349737385, 4831.73425461603, 5585.916211256835, 5641.294838145232, 5646.011947909182, 5684.204211410406, 5694.088945768657, 5550.722463876871, 5566.749496272759, 5569.693666848362, 5571.721413929206, 5572.582056345709, 5511.338639363142, 5691.971540142273, 5724.4275572444085, 5728.083506638918, 5743.052396354555, 5421.728913554385, 5432.320959880015, 5433.809816656398, 5436.864078398072, 5478.479544443271, 5456.290682211287, 5486.643368181056, 5497.3952865184, 5502.0, 5510.779568817203, 5303.496167864047, 5322.068637988414, 5363.329583802025, 5400.864978375572, 5432.049391356576, 5407.648502847303, 5417.322834645669, 5437.184422336682, 5441.945580544144, 5462.126059830408, 5308.4160742317545, 5311.575073993994, 5319.281896943863, 5321.7073060980465, 5368.570514358764, 5352.437994010573, 5379.4082650907585, 5465.316835395575, 5480.698561578992, 5483.341998960151, 5323.973380133075, 5326.14781634952, 5329.9467005331, 5332.813351532678, 5389.353277606712], "value": 5091.240754983552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1881001243315, 631.5263552335748, 635.0125554762345, 637.3435361577571, 639.3031595560839, 31361.843190784042, 32132.518012229837, 32177.5173372399, 32271.99999999997, 38092.238155236875, 42248.577514224846, 42933.78533107338, 43116.0, 43130.35304470435, 43140.0, 8423.157684231574, 8690.08754080822, 8712.303015758724, 8720.781980450476, 8723.432976856484, 8480.448770829908, 8621.525816080113, 8628.65485380584, 8630.093840146788, 8636.265917396997, 8639.827203455958, 8907.287417006657, 8931.866022009675, 8936.910630893706, 8948.776280592972, 8806.779830504225, 8884.955575222082, 8887.555622218895, 8893.822123557526, 8896.154865287788, 8670.306375489945, 8780.824383512358, 8786.64853405863, 8803.64785408583, 8806.20744133031, 42119.0, 42675.0, 42707.35938960887, 42788.35817462741, 42819.0, 3586.7847929124073, 3683.7605555638797, 3875.263699897039, 4060.330045542482, 4103.548609652936, 31654.208644783834, 31954.360912781845, 33404.164895877555, 33476.16309592255, 33555.83222083874, 4302.806373713191, 4346.326319420495, 4374.147041326943, 4473.597376236122, 4512.503624601291, 222099.0, 222294.0, 222834.88582557146, 222915.0, 224002.0, 56708.71645641745, 56988.71505642528, 57085.0, 57086.57283567861, 57344.0, 60991.695041525396, 61122.0, 61306.69346653238, 61430.0, 61437.38562614406, 14861.405543778345, 15001.399944002118, 15006.774898376532, 15019.549413517612, 15041.398344066334, 11856.288622682667, 11864.703382415508, 11913.523459061715, 11920.46357913896, 11923.926846583849, 15211.771823422658, 17541.824581754274, 17656.646867062842, 17669.20488578017, 17702.114894255235, 5566.860828479321, 5829.213056237439, 5835.503982161564, 5864.266966629171, 5947.197128387699, 922.6447817590142, 981.6711401680517, 1061.3260579532052, 1083.4853444613746, 1188.988110118905, 27178.5923211152, 28380.0, 28686.282842929093, 29146.562801557993, 29161.0, 1123.8763735989035, 1129.4014172488594, 1142.173121524221, 1150.2121047082608, 1193.9522419103312, 16795.32818687239, 16938.745918811226, 17194.0, 17241.482755517354, 17283.222254998556, 464117.0, 465887.0, 470900.0, 471811.0, 472006.0, 58414.7079264601, 58604.12093818596, 58660.706696466244, 58687.70656146692, 58720.0, 1261.3630116790962, 1274.6940734223906, 1395.4487977249132, 1467.3690313165441, 1496.1845794042056, 29747.107586771566, 31026.379472409975, 31285.843570782, 31489.370212596077, 32122.51816222712, 46123.30815037844, 46353.53646463492, 46582.76708616571, 46610.300845486665, 46700.0, 228622.0, 228724.0, 229270.0, 229591.0, 229770.0, 31542.0, 37208.44187337246, 37773.81113094417, 37959.240815184094, 37982.43026354662, 41314.79342603268, 41657.166856662094, 41735.0, 42643.78678106714, 42753.0, 37849.62150378571, 38409.0, 39122.41316380313, 39217.21565568616, 39612.0, 39155.21689566136, 39697.2060558793, 39726.2054758909, 39818.60181398265, 40486.392704108875, 35871.82064089663, 37154.25691486209, 37295.81352093222, 38836.41745373765, 38875.416868746426, 31277.0, 33273.667263328025, 33578.83210583931, 33719.63962522698, 33787.0, 26050.478990419706, 26944.191674249803, 27028.864855675594, 27205.86397068002, 27484.58773118365], "value": 18896.2189562017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2699825837005, 385.2180074448868, 390.17478033958184, 395.6893838336906, 396.1364225987348, 17132.743008854875, 18779.718304225447, 18798.624027519443, 18801.059947002628, 19290.614187716274, 17859.19633616487, 17969.281228750868, 18464.907675461636, 18618.53453663659, 18626.161822717975, 5471.72641367932, 5527.917081243784, 5598.776048958037, 5642.407547207526, 5650.3219613646215, 5427.48438898304, 5587.497125258726, 5624.831255062355, 5635.154726790994, 5640.5487560995225, 5421.701806400646, 5554.8611284718, 5555.055640541097, 5562.833115006556, 5565.332160140789, 5369.382521010075, 5511.338639363262, 5541.972290138564, 5545.390007099216, 5549.861253468655, 3898.4542164097047, 4924.236743304794, 4944.035912996967, 4947.0, 4951.653384263103, 22408.103675853108, 22602.77397226023, 22822.88588557063, 22909.427264318358, 22913.656295155586, 2300.861948283108, 2311.3759284993125, 2327.301809457173, 2377.251165882759, 2383.5352106339096, 13817.447302108005, 14332.785008224884, 14335.641608959755, 14413.13521188732, 14565.198914059722, 1896.5637903282184, 1947.289239427613, 2004.518915460279, 2019.8283145932614, 2050.8974551272377, 79368.60315698442, 81197.0, 81806.0, 81839.59080204621, 82742.58628706817, 10190.490475476197, 10217.18262538995, 10700.678979630624, 10748.570057197625, 10915.836262456069, 14902.031367961048, 14979.400823967137, 14989.550313490394, 14999.475018374305, 15008.774868376982, 7672.117706463717, 7821.960890195626, 7841.529508229524, 7910.446268761131, 7965.322947549407, 7377.704891804267, 7477.364424024019, 7488.0, 7597.620118994028, 7614.2766437188375, 6623.30455302196, 6661.700223489955, 6687.762763888599, 6704.161979752531, 6710.932890671031, 1854.4436668999247, 1874.3065065925696, 1895.8009409011854, 1896.838768704648, 1908.1127275816812, 927.638221093774, 1026.5013080901967, 1035.6841163445222, 1051.673981065872, 1082.2478377527543, 18980.62038759217, 19037.0, 19592.70610940837, 19635.705464418046, 19696.70454943177, 1028.2236911132047, 1055.5039131608132, 1058.3385384134915, 1066.3495267886583, 1069.2141276162015, 10837.83743243852, 11247.381394023243, 11264.54941802335, 11303.773924521463, 11381.943090284662, 471487.0, 476160.0, 482715.0, 485276.0, 487795.2933059411, 81365.0, 82017.17982820095, 82048.17951820405, 82115.5894220537, 82361.17638823655, 1003.844404117363, 1049.35989046683, 1050.406520316019, 1062.5537274344795, 1062.6493257225097, 16319.020858748512, 16667.333306668083, 16962.66074678524, 16990.49028529146, 17742.91128544349, 36835.0, 37620.62379376171, 38774.80612596919, 40134.397984030846, 40306.395404068375, 48320.0, 49417.50582494129, 52329.0, 54178.45821541734, 54385.72807135939, 8219.83560328802, 8368.121347258693, 8402.537860417735, 8547.487150770974, 8628.439151455135, 11513.654590362303, 13271.535496257584, 13417.865821342051, 13425.798613020617, 13601.523946661819, 11394.088472922313, 11859.881401185878, 11963.880361196625, 11975.64073077809, 12020.33888136126, 11797.941010294893, 11830.11274154459, 11844.881551184722, 11863.0, 11930.164888457724, 11719.472623731783, 11724.648260552198, 11849.763004740029, 12010.699732506408, 12400.503979840705, 7899.723509677134, 8055.033395992518, 8061.072976607765, 8383.245507904317, 8509.74470765878, 8351.874721879056, 10796.329584676487, 11303.71740706456, 11401.916817902285, 11524.59663911759], "value": 9177.173691409605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.5104335874048, 1459.7883306920496, 1476.1954734669605, 1583.216307927576, 1727.9222434990425, 7514.887276690847, 7898.210178982099, 7912.485688430248, 7913.0, 7916.485428447147, 7644.885326720104, 7826.8043298917555, 7836.843263134734, 7842.333401660851, 7847.058352997634, 2135.220644464771, 2161.5352699169753, 2164.3723320237114, 2164.3831508020216, 2164.4805246740825, 2092.4978005278776, 2104.0, 2161.729783777028, 2171.446281198292, 2172.9022194001227, 2100.1179504608026, 2114.312848324293, 2117.449463139587, 2120.5652841167603, 2157.331227319536, 2101.3380785052736, 2106.273335699181, 2108.736407949006, 2108.778578249277, 2114.1332053858, 2007.4579863436936, 2055.537504061574, 2066.6693329067275, 2067.886266255355, 2076.0553947953795, 7616.124145723257, 7874.803129921798, 7889.684412623488, 7970.760877173694, 7983.481073730247, 4533.863984080483, 4671.229247174212, 4682.180618391768, 4690.0, 4701.7414042227665, 3079.3995170941675, 3119.6412412572618, 3167.33485967947, 3183.060997005889, 3201.399300349825, 984.9015098490165, 996.5366104761321, 1009.8535712321745, 1013.989860101397, 1026.8819085805153, 10781.137508999262, 10988.340699557972, 10993.34039957597, 10998.725031874186, 11018.0, 4168.708190426702, 4214.683898707548, 4281.892952676208, 4306.913861722748, 4309.310510318334, 9378.67174648884, 9453.952730236442, 9481.525923703788, 9486.383385079947, 9487.66793162236, 4789.401324834395, 4808.3027960946165, 4816.109019831272, 4820.6143508519235, 4821.421429428421, 3698.2973235085246, 3807.58116607173, 4259.254630439661, 4365.257906155961, 4411.426514553087, 3730.813459327023, 3766.7174961877968, 3809.12390150267, 3814.561325447609, 3847.0, 1139.145640769423, 1146.5585749486509, 1156.6876943225282, 1156.7975604269388, 1161.1581603337513, 873.0527377795163, 914.9313801464783, 942.9387089839139, 948.0803620488116, 966.1449617088787, 5529.751161197756, 5567.66594004361, 5669.574781891292, 5872.060470324813, 5879.323877754027, 891.8483857744199, 922.5295099499303, 929.0477260807726, 970.9271804614682, 979.1725991537139, 3802.6387493188104, 4030.7783071931326, 4080.2859499587453, 4097.713160078825, 4113.197926404382, 9613.279004074722, 9956.950215249022, 10007.599696012077, 10047.748806279755, 10065.446400448045, 9755.219582433388, 9766.36518626287, 9879.506024698736, 9882.11061004513, 9930.652427165014, 7571.167171611119, 7649.617519124022, 7663.540187588763, 7684.46208765381, 7747.767566973, 5534.0, 5622.606417550732, 5679.290088738908, 5736.885262294647, 5786.508146807569, 8710.564471776259, 8843.823123537364, 8956.28349732033, 9034.593443294936, 9039.096090390909, 8739.169778870997, 9109.453432794053, 9122.315826313186, 9123.589438475152, 9161.679341223025, 6349.460295874902, 6514.055461958084, 6647.567908085959, 6844.4182244509775, 6861.691223894837, 7205.279472052753, 7210.9278907210255, 7218.458615603956, 7250.0, 7282.417406607353, 6559.27847936717, 6576.506761992774, 6631.403173714389, 6658.201015878126, 6793.490488213305, 6623.3376662333385, 6694.0, 6713.227978782503, 6719.865602687821, 6762.087118239171, 5934.643921364732, 6061.9393806063135, 6306.905396419149, 6314.494840412848, 6371.585846920121, 4566.2237419639405, 4578.0, 4766.976165119152, 4932.605391568594, 4991.900161996812, 4884.5603895649565, 5012.248162775612, 5093.617978651542, 5153.201253805666, 5212.687238765686], "value": 4239.407405294959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.4277174265597, 286.40285005762985, 286.9713028697132, 287.8474408563462, 289.41682509742867, 5153.407358153813, 5188.184135552559, 5212.582993360532, 5235.764390602422, 5237.554807841333, 5177.378714554249, 5180.093483640358, 5187.9740601297035, 5192.766325515351, 5214.374275086985, 3787.280416720821, 3842.5773164951834, 3961.187956468917, 3978.9204215915665, 3993.3011722948513, 3947.3486874665646, 3951.6443520083185, 3955.624215699504, 3968.503937007874, 3990.481237439129, 3756.248750249947, 3901.765894046366, 3941.1723538057045, 3945.9408108878247, 3968.7420317679403, 3827.311084004878, 3917.5103112110987, 3925.0187453136714, 3944.8816535504125, 3965.266425711253, 3442.6729460701195, 3443.5867695876404, 3454.222799870009, 3456.5333679953387, 3482.355764183634, 5021.121303771862, 5022.54797068262, 5023.899522009539, 5029.3964724232965, 5034.3455350804525, 4283.742975421454, 4497.460304763449, 4504.572065653758, 4545.681802273843, 4566.703164294344, 5352.625316227865, 5366.91949620756, 5394.541463975567, 5405.594580406446, 5425.701586412746, 3803.8858834235016, 3806.3148633246283, 3809.6190380961957, 3816.2367526494536, 3822.4648549203134, 5524.889502209933, 5610.513213998293, 5634.915476267859, 5645.350784659776, 5685.40303268155, 3866.188100498927, 3872.3997780344093, 3884.669803066771, 3884.7474914131058, 3893.922121557553, 3923.1172986077904, 3925.156091440354, 3925.941110883339, 3942.3692209246383, 3960.2277555876904, 4391.253486907233, 4527.253003254426, 4534.659900507475, 4539.818407263672, 4554.95445045552, 5428.37573679032, 5438.7280635968045, 5439.782408703608, 5440.102383106743, 5488.890222195534, 1408.8943329250142, 1421.175718083509, 1427.307755738466, 1428.3929330034694, 1432.2767002663797, 876.8027193881453, 926.4395041000232, 928.7724507495572, 952.5332587032443, 960.2366118935323, 5558.749856256478, 5575.776968921197, 5601.29983752031, 5607.214989901417, 5622.718864056863, 5943.5839491236065, 5946.256717910262, 5963.642181469126, 5969.701514924236, 5993.130996005555, 5385.542228910508, 5533.22534845122, 5575.689712917461, 5594.468525490072, 5616.775328986876, 3123.9062828115193, 3147.62228532573, 3150.7951983121025, 3154.274516861135, 3166.667499912522, 5973.402659734079, 6062.969685151546, 6078.848028799315, 6087.543434242361, 6095.847603809941, 5946.524278057745, 5999.5800293979, 6004.4088316596135, 6016.097585362143, 6042.848928776816, 6021.5182785377065, 6043.123747056652, 6054.66699331541, 6071.3928607139815, 6091.817245482643, 5379.1662292344745, 5662.235598194191, 5693.551772737763, 5709.486146246858, 5709.9714501427225, 5600.831975040755, 5615.831525054255, 5621.437856214346, 5631.380548139619, 5632.352279487911, 5648.661080335193, 5806.796762113306, 5833.387494313036, 5860.271219990028, 5871.6770577618645, 3755.286495565834, 3782.829772660292, 3791.0711875590655, 3814.27528769544, 3820.541535015816, 5679.772809087755, 5709.457601527848, 5714.742836572281, 5734.483896449339, 5740.6268592541355, 5429.267048948342, 5449.509544141047, 5484.61607687458, 5528.751206195811, 5531.9723401382735, 5457.508824205841, 5465.070937940639, 5508.779648814163, 5519.31008623922, 5547.613096725819, 5113.386393632788, 5159.509846564571, 5261.421243663271, 5358.33020872391, 5411.78352865881, 5490.81947381315, 5520.66875987442, 5524.226608274765, 5539.612227144223, 5549.778008879761, 5426.620136590401, 5446.700431476307, 5458.2904222450825, 5458.727063646881, 5489.313835770528], "value": 4164.101643303193, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.2071785960392, 758.9658465369058, 765.1736124985017, 768.1818862910998, 779.0884664942017, 12816.23102613844, 13133.605991820237, 13198.076134670577, 13227.867721322784, 13230.735385292288, 12427.502899884017, 12476.438560264787, 12476.563320283793, 12489.12576119672, 12489.687757806038, 673.9561928474634, 793.7499687598416, 807.733447962174, 817.1011886924395, 817.2807929022451, 800.7077416742876, 810.7648781853255, 810.9716159934403, 811.2739098506833, 811.663159788687, 856.3834039491556, 864.6714248585529, 866.0084203586889, 866.5234121233328, 867.1675191815864, 711.9537230080028, 827.9379046571471, 848.3171047306915, 854.8204876975842, 859.7506723050308, 628.0673200297555, 628.8899442597573, 629.0155906007084, 629.7732816186169, 630.9905351419733, 12708.173968692097, 12735.872641273561, 12747.745045099138, 12755.298458584773, 12768.425420856083, 12543.749125017539, 13022.218666879922, 13072.215667060007, 13094.47622095115, 13259.734805303937, 10727.409992450412, 10739.400593916134, 10850.348979061282, 10931.070858976997, 11186.384748838811, 3688.520492336006, 3731.5708693500324, 3743.9438408423894, 3753.230587729509, 3781.6785573226307, 51941.48058519442, 52057.479425205645, 54382.456175438136, 55272.0, 55405.72297138489, 9960.80078398428, 9993.950030249802, 10042.0, 10067.647632332833, 10206.591736330613, 16431.096289704183, 16466.75299870503, 16516.0, 16559.586010349598, 16589.336426542803, 7995.800104997305, 8020.35837133028, 8166.305864001508, 8238.052623948202, 8363.749087527383, 4644.814207431732, 4657.083700702409, 4674.439067311944, 4771.021940502189, 4830.541098595628, 3154.794938329001, 3247.253131779704, 3257.641659417462, 3259.869605215812, 3265.706086452183, 547.1082136118102, 562.3083607163212, 564.9576531299746, 569.4931510955253, 579.7767859374171, 580.7822066724979, 597.7160848596882, 614.9631022138686, 648.5784240243785, 708.861771954464, 8234.917650823534, 8942.329325300629, 8946.552672366355, 8957.641694332284, 9147.634094636272, 690.1200968764765, 699.2902204262678, 702.4766548921086, 713.9464540159508, 716.6488420673833, 4038.5355684096116, 4183.3967709032895, 4260.914781704349, 4289.592488713567, 4383.662982790216, 60243.0, 61736.69131654403, 62049.68975155186, 62470.68764656239, 62511.68744156341, 54685.72657136768, 55262.447375526535, 55615.44384556184, 56096.0, 56893.0, 47731.28403073957, 48165.5183448168, 48282.758586206844, 48360.0, 50119.74940125349, 8550.187732165434, 8643.17889800468, 8663.0, 8701.825963480822, 8845.646174152962, 32968.34063318768, 33218.66781332156, 33282.33435331231, 33923.83038084794, 34631.82684086664, 42113.57886421219, 43269.78365108154, 43337.78331108324, 44248.77875610601, 45194.54805451904, 11753.236039657395, 11855.52577896909, 11877.76244475123, 11971.341576213392, 12001.879981200076, 12872.420741066862, 12945.28800915921, 12956.481740730265, 13034.804477932648, 13241.0, 12070.45682944252, 12086.818697719365, 12113.69715757113, 12468.251904885736, 12771.042171836963, 11851.644450666494, 12048.638540843789, 12053.81919271194, 12138.0, 12296.815547766611, 11932.105092117952, 11963.282203067844, 11963.581274655346, 12011.75976480448, 12030.63908082759, 9892.520399138575, 10107.747306317107, 10302.536385862804, 10508.054275115277, 10565.207609429477, 9695.660651877433, 10051.849222261819, 10187.592496300065, 10227.84658230142, 10242.436665983443], "value": 6458.989539308801, "unit": "score"}], "name": "dromaeo_css", "value": 6820.627747246049, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 106.0, 110.0, 112.0, 113.0, 102.0, 111.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 154.0, 189.0, 129.0, 155.0, 157.0, 129.0, 181.0, 129.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 114.0, 107.0, 74.0, 75.0, 75.0, 128.0, 104.0, 75.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 154.0, 95.0, 93.0, 94.0, 153.0, 94.0, 94.0, 161.0], "value": 112.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 59.0, 56.0, 57.0, 57.0, 58.0, 83.0, 58.0, 53.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 72.0, 62.0, 62.0, 61.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 77.0, 78.0, 79.0, 79.0, 78.0, 87.0, 79.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 124.0, 125.0, 123.0, 121.0, 128.0, 128.0, 158.0, 125.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 181.0, 170.0, 171.0, 168.0, 172.0, 168.0, 169.0, 168.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 70.0, 71.0, 70.0, 70.0, 69.0, 69.0, 70.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1553.2, "alertThreshold": 2.0}]} 22:42:40 INFO - Return code: 0 22:42:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:42:40 ERROR - # TBPL SUCCESS # 22:42:40 INFO - Running post-action listener: _resource_record_post_action 22:42:40 INFO - Running post-run listener: _resource_record_post_run 22:42:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 359735296; Read time: 0; Write time: 657756 22:42:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 72634368; Read time: 0; Write time: 117168 22:42:41 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 287100928; Read time: 0; Write time: 540588 22:42:41 INFO - Running post-run listener: _upload_blobber_files 22:42:41 INFO - Blob upload gear active. 22:42:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:42:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:42:41 INFO - (blobuploader) - INFO - Open directory for files ... 22:42:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:42:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:42 INFO - (blobuploader) - INFO - Done attempting. 22:42:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:42:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:42:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:42:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:42:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:42:43 INFO - (blobuploader) - INFO - Done attempting. 22:42:43 INFO - (blobuploader) - INFO - Iteration through files over. 22:42:43 INFO - Return code: 0 22:42:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:42:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:42:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abe83e2813498d22a5d17f2a3a792b825b90eefb43b4adedf5db5abc6b5999870d9b3d68aa1e381d950c42e661355441504e2edae749216c74f4ccf432342d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e243cd0890c384df137075e41be06375b1023a07ba84f3b14f4b079454e5d580dbacece20c0bbac26c232f281b3881922c3b4ea9fd865070f719bdb67e5066be"} 22:42:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:42:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:42:43 INFO - Contents: 22:42:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abe83e2813498d22a5d17f2a3a792b825b90eefb43b4adedf5db5abc6b5999870d9b3d68aa1e381d950c42e661355441504e2edae749216c74f4ccf432342d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e243cd0890c384df137075e41be06375b1023a07ba84f3b14f4b079454e5d580dbacece20c0bbac26c232f281b3881922c3b4ea9fd865070f719bdb67e5066be"} 22:42:43 INFO - Running post-run listener: copy_logs_to_upload_dir 22:42:43 INFO - Copying logs to upload dir... 22:42:43 INFO - mkdir: /builds/slave/test/build/upload/logs 22:42:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2129.888495 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 29 secs) (at 2016-05-02 22:42:41.403416) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 22:42:41.407123) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abe83e2813498d22a5d17f2a3a792b825b90eefb43b4adedf5db5abc6b5999870d9b3d68aa1e381d950c42e661355441504e2edae749216c74f4ccf432342d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e243cd0890c384df137075e41be06375b1023a07ba84f3b14f4b079454e5d580dbacece20c0bbac26c232f281b3881922c3b4ea9fd865070f719bdb67e5066be"} build_url:https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/U0rjmRY0TZ6eCgu5YvB2DQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/abe83e2813498d22a5d17f2a3a792b825b90eefb43b4adedf5db5abc6b5999870d9b3d68aa1e381d950c42e661355441504e2edae749216c74f4ccf432342d19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e243cd0890c384df137075e41be06375b1023a07ba84f3b14f4b079454e5d580dbacece20c0bbac26c232f281b3881922c3b4ea9fd865070f719bdb67e5066be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-02 22:42:41.431889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:42:41.432213) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1462239730.281789-1125650003 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-02 22:42:41.514559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 22:42:41.514886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-02 22:42:41.515191) ========= ========= Total master_lag: 0.15 =========