builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1462379007.71 results: success (0) buildid: 20160504064752 builduid: 601f0d00cff044f9ab62de27c29b4002 revision: 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.712184) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.712623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.712903) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.729399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.729664) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-04 09:23:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.9M=0s 2016-05-04 09:23:28 (30.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.882563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.882841) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014925 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:27.971950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 09:23:27.972413) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 --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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-04 09:23:28,167 truncating revision to first 12 chars 2016-05-04 09:23:28,167 Setting DEBUG logging. 2016-05-04 09:23:28,167 attempt 1/10 2016-05-04 09:23:28,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b9c6eb81f85?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-04 09:23:29,208 unpacking tar archive at: mozilla-aurora-4b9c6eb81f85/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-04 09:23:29.333767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:29.334218) ========= script_repo_revision: 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:29.334749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:29.335116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-04 09:23:29.345807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 29 secs) (at 2016-05-04 09:23:29.346190) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:29 INFO - MultiFileLogger online at 20160504 09:23:29 in /builds/slave/test 09:23:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:23:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:29 INFO - {'append_to_log': False, 09:23:29 INFO - 'base_work_dir': '/builds/slave/test', 09:23:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:23:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:29 INFO - 'branch': 'Mozilla-Aurora', 09:23:29 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:29 INFO - 'config_files': ('talos/linux_config.py',), 09:23:29 INFO - 'default_actions': ('clobber', 09:23:29 INFO - 'read-buildbot-config', 09:23:29 INFO - 'download-and-extract', 09:23:29 INFO - 'populate-webroot', 09:23:29 INFO - 'create-virtualenv', 09:23:29 INFO - 'install', 09:23:29 INFO - 'run-tests'), 09:23:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:29 INFO - 'download_minidump_stackwalk': True, 09:23:29 INFO - 'download_symbols': 'ondemand', 09:23:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:29 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:29 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:29 INFO - 'installer_path': 'installer.exe', 09:23:29 INFO - 'log_level': 'info', 09:23:29 INFO - 'log_name': 'talos', 09:23:29 INFO - 'log_to_console': True, 09:23:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:29 INFO - 'opt_config_files': (), 09:23:29 INFO - 'pip_index': False, 09:23:29 INFO - 'sps_profile': False, 09:23:29 INFO - 'sps_profile_interval': 0, 09:23:29 INFO - 'suite': 'dromaeojs', 09:23:29 INFO - 'system_bits': '32', 09:23:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:29 INFO - 'title': 'talos-linux64-ix-036', 09:23:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:29 INFO - 'use_talos_json': True, 09:23:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:29 INFO - 'work_dir': 'build'} 09:23:29 INFO - ##### 09:23:29 INFO - ##### Running clobber step. 09:23:29 INFO - ##### 09:23:29 INFO - Running pre-action listener: _resource_record_pre_action 09:23:29 INFO - Running main action method: clobber 09:23:29 INFO - rmtree: /builds/slave/test/build 09:23:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:30 INFO - Running post-action listener: _resource_record_post_action 09:23:30 INFO - ##### 09:23:30 INFO - ##### Running read-buildbot-config step. 09:23:30 INFO - ##### 09:23:30 INFO - Running pre-action listener: _resource_record_pre_action 09:23:30 INFO - Running main action method: read_buildbot_config 09:23:30 INFO - Using buildbot properties: 09:23:30 INFO - { 09:23:30 INFO - "project": "", 09:23:30 INFO - "product": "firefox", 09:23:30 INFO - "script_repo_revision": "production", 09:23:30 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:23:30 INFO - "repository": "", 09:23:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:23:30 INFO - "buildid": "20160504064752", 09:23:30 INFO - "pgo_build": "True", 09:23:30 INFO - "basedir": "/builds/slave/test", 09:23:30 INFO - "buildnumber": 214, 09:23:30 INFO - "slavename": "talos-linux64-ix-036", 09:23:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:23:30 INFO - "platform": "ubuntu64_hw", 09:23:30 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:23:30 INFO - "branch": "mozilla-aurora", 09:23:30 INFO - "repo_path": "releases/mozilla-aurora", 09:23:30 INFO - "revision": "4b9c6eb81f85bc3474a284a831b6ff33344e33a4", 09:23:30 INFO - "stage_platform": "linux64-pgo", 09:23:30 INFO - "builduid": "601f0d00cff044f9ab62de27c29b4002", 09:23:30 INFO - "slavebuilddir": "test" 09:23:30 INFO - } 09:23:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 09:23:30 INFO - Running post-action listener: _resource_record_post_action 09:23:30 INFO - ##### 09:23:30 INFO - ##### Running download-and-extract step. 09:23:30 INFO - ##### 09:23:30 INFO - Running pre-action listener: _resource_record_pre_action 09:23:30 INFO - Running main action method: download_and_extract 09:23:30 INFO - mkdir: /builds/slave/test/build/tests 09:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:30 INFO - https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:23:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:23:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:23:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:24:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 09:24:00 INFO - retry: attempt #1 caught exception: timed out 09:24:00 INFO - retry: Failed, sleeping 30 seconds before retrying 09:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 09:25:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 09:25:00 INFO - retry: attempt #2 caught exception: timed out 09:25:00 INFO - retry: Failed, sleeping 60 seconds before retrying 09:26:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 09:26:30 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 09:26:30 INFO - retry: attempt #3 caught exception: timed out 09:26:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json! 09:26:30 INFO - Caught exception: timed out 09:26:30 INFO - Caught exception: timed out 09:26:30 INFO - Caught exception: timed out 09:26:30 INFO - trying https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:26:30 INFO - Downloading https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:26:31 INFO - Downloaded 1361 bytes. 09:26:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 09:26:31 INFO - Using the following test package requirements: 09:26:31 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:26:31 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:26:31 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:26:31 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'jsshell-linux-x86_64.zip'], 09:26:31 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:26:31 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 09:26:31 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:26:31 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:26:31 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:26:31 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 09:26:31 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:26:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:26:31 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')]} 09:26:31 INFO - https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:26:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:26:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:26:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:26:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:27:01 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:27:01 INFO - retry: attempt #1 caught exception: timed out 09:27:01 INFO - retry: Failed, sleeping 30 seconds before retrying 09:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:28:01 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:28:01 INFO - retry: attempt #2 caught exception: timed out 09:28:01 INFO - retry: Failed, sleeping 60 seconds before retrying 09:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 09:29:31 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:29:31 INFO - retry: attempt #3 caught exception: timed out 09:29:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 09:29:31 INFO - Caught exception: timed out 09:29:31 INFO - Caught exception: timed out 09:29:31 INFO - Caught exception: timed out 09:29:31 INFO - trying https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:29:31 INFO - Downloading https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:29:32 INFO - Downloaded 23823959 bytes. 09:29:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:29:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:29:34 INFO - Return code: 0 09:29:34 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:29:34 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')]} 09:29:34 INFO - https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:29:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:29:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:29:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:30:04 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:30:04 INFO - retry: attempt #1 caught exception: timed out 09:30:04 INFO - retry: Failed, sleeping 30 seconds before retrying 09:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:31:04 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:31:04 INFO - retry: attempt #2 caught exception: timed out 09:31:04 INFO - retry: Failed, sleeping 60 seconds before retrying 09:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 09:32:34 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 09:32:34 INFO - retry: attempt #3 caught exception: timed out 09:32:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip! 09:32:34 INFO - Caught exception: timed out 09:32:34 INFO - Caught exception: timed out 09:32:34 INFO - Caught exception: timed out 09:32:34 INFO - trying https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 09:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:32:35 INFO - Downloaded 23823959 bytes. 09:32:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:32:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:32:36 INFO - Return code: 0 09:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:32:36 INFO - https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:32:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:32:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:32:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:32:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:33:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 09:33:06 INFO - retry: attempt #1 caught exception: timed out 09:33:06 INFO - retry: Failed, sleeping 30 seconds before retrying 09:33:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 09:34:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 09:34:06 INFO - retry: attempt #2 caught exception: timed out 09:34:06 INFO - retry: Failed, sleeping 60 seconds before retrying 09:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 09:35:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 09:35:37 INFO - retry: attempt #3 caught exception: timed out 09:35:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip! 09:35:37 INFO - Caught exception: timed out 09:35:37 INFO - Caught exception: timed out 09:35:37 INFO - Caught exception: timed out 09:35:37 INFO - trying https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:37 INFO - Downloading https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 09:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:35:38 INFO - Downloaded 10840145 bytes. 09:35:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:35:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:35:38 INFO - Return code: 0 09:35: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')]} 09:35:38 INFO - https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:36:08 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 09:36:08 INFO - retry: attempt #1 caught exception: timed out 09:36:08 INFO - retry: Failed, sleeping 30 seconds before retrying 09:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 09:37:08 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 09:37:08 INFO - retry: attempt #2 caught exception: timed out 09:37:08 INFO - retry: Failed, sleeping 60 seconds before retrying 09:38:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 09:38:38 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 09:38:38 INFO - retry: attempt #3 caught exception: timed out 09:38:38 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2! 09:38:38 INFO - Caught exception: timed out 09:38:38 INFO - Caught exception: timed out 09:38:38 INFO - Caught exception: timed out 09:38:38 INFO - trying https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:38:38 INFO - Downloading https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:38:39 INFO - Downloaded 62680717 bytes. 09:38:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:38:39 INFO - mkdir: /builds/slave/test/properties 09:38:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:39 INFO - Contents: 09:38:39 INFO - build_url:https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 09:38:40 INFO - Running post-action listener: _resource_record_post_action 09:38:40 INFO - Running post-action listener: set_extra_try_arguments 09:38:40 INFO - ##### 09:38:40 INFO - ##### Running populate-webroot step. 09:38:40 INFO - ##### 09:38:40 INFO - Running pre-action listener: _resource_record_pre_action 09:38:40 INFO - Running main action method: populate_webroot 09:38:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:40 INFO - '--tppagecycles', 09:38:40 INFO - '7'], 09:38:40 INFO - 'tests': ['tsvgm']}}, 09:38:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['damp', 'tps']}, 09:38:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'tests': ['damp', 'tps']}, 09:38:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['dromaeo_dom']}, 09:38:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['a11yr', 09:38:40 INFO - 'ts_paint', 09:38:40 INFO - 'tpaint', 09:38:40 INFO - 'sessionrestore', 09:38:40 INFO - 'sessionrestore_no_auto_restore', 09:38:40 INFO - 'tabpaint']}, 09:38:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['tsvgx', 09:38:40 INFO - 'tsvgr_opacity', 09:38:40 INFO - 'tart', 09:38:40 INFO - 'tscrollx', 09:38:40 INFO - 'cart']}, 09:38:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:40 INFO - 'tsvgr_opacity', 09:38:40 INFO - 'tart', 09:38:40 INFO - 'tscrollx', 09:38:40 INFO - 'cart']}, 09:38:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'talos_options': ['--disable-e10s'], 09:38:40 INFO - 'tests': ['tp5o']}, 09:38:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'tests': ['tp5o']}, 09:38:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'talos_options': ['--disable-e10s', 09:38:40 INFO - '--xperf_path', 09:38:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:40 INFO - 'tests': ['tp5n']}, 09:38:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:40 INFO - 'talos_options': ['--xperf_path', 09:38:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:40 INFO - 'tests': ['tp5n']}}, 09:38:40 INFO - 'talos.zip': {'path': '', 09:38:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:40 INFO - Running post-action listener: _resource_record_post_action 09:38:40 INFO - ##### 09:38:40 INFO - ##### Running create-virtualenv step. 09:38:40 INFO - ##### 09:38:40 INFO - Running pre-action listener: _resource_record_pre_action 09:38:40 INFO - Running main action method: create_virtualenv 09:38:40 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:40 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 09:38:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:40 INFO - Using real prefix '/usr' 09:38:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:43 INFO - Installing pip.................done. 09:38:43 INFO - Return code: 0 09:38:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:43 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')]} 09:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:43 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')]} 09:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:43 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:43 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 09:38:43 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 09:38:43 INFO - Using env: {'DISPLAY': ':0', 09:38:43 INFO - 'HOME': '/home/cltbld', 09:38:43 INFO - 'LANG': 'en_US.UTF-8', 09:38:43 INFO - 'LANGUAGE': 'en_US:en', 09:38:43 INFO - 'LOGNAME': 'cltbld', 09:38:43 INFO - 'MAIL': '/var/mail/cltbld', 09:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:43 INFO - 'MOZ_NO_REMOTE': '1', 09:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:43 INFO - 'NO_EM_RESTART': '1', 09:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:43 INFO - 'PWD': '/builds/slave/test', 09:38:43 INFO - 'SHELL': '/bin/bash', 09:38:43 INFO - 'SHLVL': '1', 09:38:43 INFO - 'TERM': 'linux', 09:38:43 INFO - 'TMOUT': '86400', 09:38:43 INFO - 'USER': 'cltbld', 09:38:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:43 INFO - '_': '/tools/buildbot/bin/python'} 09:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:43 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 09:38:43 INFO - Cleaning up... 09:38:43 INFO - Return code: 0 09:38:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:38:43 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')]} 09:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:43 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')]} 09:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:43 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:43 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 09:38:43 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 09:38:43 INFO - Using env: {'DISPLAY': ':0', 09:38:43 INFO - 'HOME': '/home/cltbld', 09:38:43 INFO - 'LANG': 'en_US.UTF-8', 09:38:43 INFO - 'LANGUAGE': 'en_US:en', 09:38:43 INFO - 'LOGNAME': 'cltbld', 09:38:43 INFO - 'MAIL': '/var/mail/cltbld', 09:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:43 INFO - 'MOZ_NO_REMOTE': '1', 09:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:43 INFO - 'NO_EM_RESTART': '1', 09:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:43 INFO - 'PWD': '/builds/slave/test', 09:38:43 INFO - 'SHELL': '/bin/bash', 09:38:43 INFO - 'SHLVL': '1', 09:38:43 INFO - 'TERM': 'linux', 09:38:43 INFO - 'TMOUT': '86400', 09:38:43 INFO - 'USER': 'cltbld', 09:38:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:43 INFO - '_': '/tools/buildbot/bin/python'} 09:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:43 INFO - Downloading/unpacking psutil>=0.7.1 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:45 INFO - Installing collected packages: psutil 09:38:45 INFO - Running setup.py install for psutil 09:38:45 INFO - building 'psutil._psutil_linux' extension 09:38:45 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 09:38:45 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 09:38:45 INFO - building 'psutil._psutil_posix' extension 09:38:45 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 09:38:45 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 09:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:45 INFO - Successfully installed psutil 09:38:45 INFO - Cleaning up... 09:38:46 INFO - Return code: 0 09:38:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:46 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:46 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 09:38:46 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 09:38:46 INFO - Using env: {'DISPLAY': ':0', 09:38:46 INFO - 'HOME': '/home/cltbld', 09:38:46 INFO - 'LANG': 'en_US.UTF-8', 09:38:46 INFO - 'LANGUAGE': 'en_US:en', 09:38:46 INFO - 'LOGNAME': 'cltbld', 09:38:46 INFO - 'MAIL': '/var/mail/cltbld', 09:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:46 INFO - 'MOZ_NO_REMOTE': '1', 09:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:46 INFO - 'NO_EM_RESTART': '1', 09:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:46 INFO - 'PWD': '/builds/slave/test', 09:38:46 INFO - 'SHELL': '/bin/bash', 09:38:46 INFO - 'SHLVL': '1', 09:38:46 INFO - 'TERM': 'linux', 09:38:46 INFO - 'TMOUT': '86400', 09:38:46 INFO - 'USER': 'cltbld', 09:38:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:46 INFO - '_': '/tools/buildbot/bin/python'} 09:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:46 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 09:38:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:38:48 INFO - Installing collected packages: mozsystemmonitor 09:38:48 INFO - Running setup.py install for mozsystemmonitor 09:38:48 INFO - Successfully installed mozsystemmonitor 09:38:48 INFO - Cleaning up... 09:38:48 INFO - Return code: 0 09:38:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:48 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:48 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 09:38:48 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 09:38:48 INFO - Using env: {'DISPLAY': ':0', 09:38:48 INFO - 'HOME': '/home/cltbld', 09:38:48 INFO - 'LANG': 'en_US.UTF-8', 09:38:48 INFO - 'LANGUAGE': 'en_US:en', 09:38:48 INFO - 'LOGNAME': 'cltbld', 09:38:48 INFO - 'MAIL': '/var/mail/cltbld', 09:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:48 INFO - 'MOZ_NO_REMOTE': '1', 09:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:48 INFO - 'NO_EM_RESTART': '1', 09:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:48 INFO - 'PWD': '/builds/slave/test', 09:38:48 INFO - 'SHELL': '/bin/bash', 09:38:48 INFO - 'SHLVL': '1', 09:38:48 INFO - 'TERM': 'linux', 09:38:48 INFO - 'TMOUT': '86400', 09:38:48 INFO - 'USER': 'cltbld', 09:38:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:48 INFO - '_': '/tools/buildbot/bin/python'} 09:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:48 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 09:38:48 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 09:38:48 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 09:38:48 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 09:38:48 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 09:38:48 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 09:38:50 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:50 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 09:38:51 INFO - Downloading docopt-0.6.1.tar.gz 09:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:51 INFO - Running setup.py install for blobuploader 09:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:51 INFO - Running setup.py install for requests 09:38:51 INFO - Running setup.py install for docopt 09:38:51 INFO - Successfully installed blobuploader requests docopt 09:38:51 INFO - Cleaning up... 09:38:51 INFO - Return code: 0 09:38:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:51 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 09:38:51 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 09:38:51 INFO - Using env: {'DISPLAY': ':0', 09:38:51 INFO - 'HOME': '/home/cltbld', 09:38:51 INFO - 'LANG': 'en_US.UTF-8', 09:38:51 INFO - 'LANGUAGE': 'en_US:en', 09:38:51 INFO - 'LOGNAME': 'cltbld', 09:38:51 INFO - 'MAIL': '/var/mail/cltbld', 09:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:51 INFO - 'MOZ_NO_REMOTE': '1', 09:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:51 INFO - 'NO_EM_RESTART': '1', 09:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:51 INFO - 'PWD': '/builds/slave/test', 09:38:51 INFO - 'SHELL': '/bin/bash', 09:38:51 INFO - 'SHLVL': '1', 09:38:51 INFO - 'TERM': 'linux', 09:38:51 INFO - 'TMOUT': '86400', 09:38:51 INFO - 'USER': 'cltbld', 09:38:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:51 INFO - '_': '/tools/buildbot/bin/python'} 09:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:52 INFO - Running setup.py (path:/tmp/pip-k0hTGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:52 INFO - Running setup.py (path:/tmp/pip-lPSWio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:52 INFO - Running setup.py (path:/tmp/pip-_h7uGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:52 INFO - Running setup.py (path:/tmp/pip-Oq2bz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:52 INFO - Running setup.py (path:/tmp/pip-Gj8ZTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:52 INFO - Running setup.py (path:/tmp/pip-B5UIDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:52 INFO - Running setup.py (path:/tmp/pip-F3ERq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:52 INFO - Running setup.py (path:/tmp/pip-mSgRql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:52 INFO - Running setup.py (path:/tmp/pip-rWQVu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:52 INFO - Running setup.py (path:/tmp/pip-TX4IsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:52 INFO - Running setup.py (path:/tmp/pip-amTqDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:52 INFO - Running setup.py (path:/tmp/pip-WKn7ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:52 INFO - Running setup.py (path:/tmp/pip-nL2mL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:52 INFO - Running setup.py (path:/tmp/pip-b3hsId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:53 INFO - Running setup.py (path:/tmp/pip-gbgwwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:53 INFO - Running setup.py (path:/tmp/pip-OW5Ojs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:53 INFO - Running setup.py (path:/tmp/pip-IhxzFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:53 INFO - Running setup.py install for manifestparser 09:38:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Running setup.py install for mozcrash 09:38:53 INFO - Running setup.py install for mozdebug 09:38:53 INFO - Running setup.py install for mozdevice 09:38:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Running setup.py install for mozfile 09:38:53 INFO - Running setup.py install for mozhttpd 09:38:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Running setup.py install for mozinfo 09:38:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:53 INFO - Running setup.py install for mozInstall 09:38:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Running setup.py install for mozleak 09:38:54 INFO - Running setup.py install for mozlog 09:38:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Running setup.py install for moznetwork 09:38:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Running setup.py install for mozprocess 09:38:54 INFO - Running setup.py install for mozprofile 09:38:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Running setup.py install for mozrunner 09:38:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:54 INFO - Running setup.py install for mozscreenshot 09:38:54 INFO - Running setup.py install for moztest 09:38:54 INFO - Running setup.py install for mozversion 09:38:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:55 INFO - Cleaning up... 09:38:55 INFO - Return code: 0 09:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:55 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:55 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 09:38:55 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 09:38:55 INFO - Using env: {'DISPLAY': ':0', 09:38:55 INFO - 'HOME': '/home/cltbld', 09:38:55 INFO - 'LANG': 'en_US.UTF-8', 09:38:55 INFO - 'LANGUAGE': 'en_US:en', 09:38:55 INFO - 'LOGNAME': 'cltbld', 09:38:55 INFO - 'MAIL': '/var/mail/cltbld', 09:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:55 INFO - 'MOZ_NO_REMOTE': '1', 09:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:55 INFO - 'NO_EM_RESTART': '1', 09:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:55 INFO - 'PWD': '/builds/slave/test', 09:38:55 INFO - 'SHELL': '/bin/bash', 09:38:55 INFO - 'SHLVL': '1', 09:38:55 INFO - 'TERM': 'linux', 09:38:55 INFO - 'TMOUT': '86400', 09:38:55 INFO - 'USER': 'cltbld', 09:38:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:55 INFO - '_': '/tools/buildbot/bin/python'} 09:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:55 INFO - Running setup.py (path:/tmp/pip-IahTvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:55 INFO - Running setup.py (path:/tmp/pip-utFSrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:55 INFO - Running setup.py (path:/tmp/pip-0GQpIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:55 INFO - Running setup.py (path:/tmp/pip-whPnZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:55 INFO - Running setup.py (path:/tmp/pip-zc4y_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:55 INFO - Running setup.py (path:/tmp/pip-vfomLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:55 INFO - Running setup.py (path:/tmp/pip-TUnn84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:55 INFO - Running setup.py (path:/tmp/pip-3MBJqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:55 INFO - Running setup.py (path:/tmp/pip-aqBLam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:55 INFO - Running setup.py (path:/tmp/pip-BXMOJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:55 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)) 09:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:55 INFO - Running setup.py (path:/tmp/pip-y508qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:56 INFO - Running setup.py (path:/tmp/pip-EngGS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:56 INFO - Running setup.py (path:/tmp/pip-yesA9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:56 INFO - Running setup.py (path:/tmp/pip-k6xwID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:56 INFO - Running setup.py (path:/tmp/pip-KukQ3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:56 INFO - Running setup.py (path:/tmp/pip-vqRDsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:56 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)) 09:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:56 INFO - Running setup.py (path:/tmp/pip-hpO0B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:56 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)) 09:38:56 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)) 09:38:56 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)) 09:38:56 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)) 09:38:56 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)) 09:38:56 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)) 09:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:58 INFO - Downloading blessings-1.6.tar.gz 09:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:58 INFO - Installing collected packages: blessings 09:38:58 INFO - Running setup.py install for blessings 09:38:58 INFO - Successfully installed blessings 09:38:58 INFO - Cleaning up... 09:38:58 INFO - Return code: 0 09:38:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:58 INFO - Reading from file tmpfile_stdout 09:38:58 INFO - Current package versions: 09:38:58 INFO - argparse == 1.2.1 09:38:58 INFO - blessings == 1.6 09:38:58 INFO - blobuploader == 1.2.4 09:38:58 INFO - docopt == 0.6.1 09:38:58 INFO - manifestparser == 1.1 09:38:58 INFO - mozInstall == 1.12 09:38:58 INFO - mozcrash == 0.17 09:38:58 INFO - mozdebug == 0.1 09:38:58 INFO - mozdevice == 0.48 09:38:58 INFO - mozfile == 1.2 09:38:58 INFO - mozhttpd == 0.7 09:38:58 INFO - mozinfo == 0.9 09:38:58 INFO - mozleak == 0.1 09:38:58 INFO - mozlog == 3.1 09:38:58 INFO - moznetwork == 0.27 09:38:58 INFO - mozprocess == 0.22 09:38:58 INFO - mozprofile == 0.28 09:38:58 INFO - mozrunner == 6.11 09:38:58 INFO - mozscreenshot == 0.1 09:38:58 INFO - mozsystemmonitor == 0.0 09:38:58 INFO - moztest == 0.7 09:38:58 INFO - mozversion == 1.4 09:38:58 INFO - psutil == 3.1.1 09:38:58 INFO - requests == 1.2.3 09:38:58 INFO - wsgiref == 0.1.2 09:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:58 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 09:38:58 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 09:38:58 INFO - Using env: {'DISPLAY': ':0', 09:38:58 INFO - 'HOME': '/home/cltbld', 09:38:58 INFO - 'LANG': 'en_US.UTF-8', 09:38:58 INFO - 'LANGUAGE': 'en_US:en', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MAIL': '/var/mail/cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SHLVL': '1', 09:38:58 INFO - 'TERM': 'linux', 09:38:58 INFO - 'TMOUT': '86400', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - '_': '/tools/buildbot/bin/python'} 09:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 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)) 09:38:59 INFO - Cleaning up... 09:38:59 INFO - Return code: 0 09:38:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:59 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:38:59 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 09:38:59 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 09:38:59 INFO - Using env: {'DISPLAY': ':0', 09:38:59 INFO - 'HOME': '/home/cltbld', 09:38:59 INFO - 'LANG': 'en_US.UTF-8', 09:38:59 INFO - 'LANGUAGE': 'en_US:en', 09:38:59 INFO - 'LOGNAME': 'cltbld', 09:38:59 INFO - 'MAIL': '/var/mail/cltbld', 09:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:59 INFO - 'MOZ_NO_REMOTE': '1', 09:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:59 INFO - 'NO_EM_RESTART': '1', 09:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:59 INFO - 'PWD': '/builds/slave/test', 09:38:59 INFO - 'SHELL': '/bin/bash', 09:38:59 INFO - 'SHLVL': '1', 09:38:59 INFO - 'TERM': 'linux', 09:38:59 INFO - 'TMOUT': '86400', 09:38:59 INFO - 'USER': 'cltbld', 09:38:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:59 INFO - '_': '/tools/buildbot/bin/python'} 09:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:59 INFO - Downloading/unpacking jsonschema 09:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:01 INFO - Downloading/unpacking functools32 (from jsonschema) 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:01 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:01 INFO - warning: no files found matching '*.txt' 09:39:01 INFO - no previously-included directories found matching 'build' 09:39:01 INFO - no previously-included directories found matching 'dist' 09:39:01 INFO - no previously-included directories found matching '.git*' 09:39:01 INFO - Installing collected packages: jsonschema, functools32 09:39:01 INFO - Running setup.py install for functools32 09:39:01 INFO - warning: no files found matching '*.txt' 09:39:01 INFO - no previously-included directories found matching 'build' 09:39:01 INFO - no previously-included directories found matching 'dist' 09:39:01 INFO - no previously-included directories found matching '.git*' 09:39:01 INFO - Successfully installed jsonschema functools32 09:39:01 INFO - Cleaning up... 09:39:01 INFO - Return code: 0 09:39:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:01 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 0x7fa0e210af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', '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 09:39:01 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 09:39:01 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 09:39:01 INFO - Using env: {'DISPLAY': ':0', 09:39:01 INFO - 'HOME': '/home/cltbld', 09:39:01 INFO - 'LANG': 'en_US.UTF-8', 09:39:01 INFO - 'LANGUAGE': 'en_US:en', 09:39:01 INFO - 'LOGNAME': 'cltbld', 09:39:01 INFO - 'MAIL': '/var/mail/cltbld', 09:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:01 INFO - 'MOZ_NO_REMOTE': '1', 09:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:01 INFO - 'NO_EM_RESTART': '1', 09:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:01 INFO - 'PWD': '/builds/slave/test', 09:39:01 INFO - 'SHELL': '/bin/bash', 09:39:01 INFO - 'SHLVL': '1', 09:39:01 INFO - 'TERM': 'linux', 09:39:01 INFO - 'TMOUT': '86400', 09:39:01 INFO - 'USER': 'cltbld', 09:39:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:01 INFO - '_': '/tools/buildbot/bin/python'} 09:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:01 INFO - Downloading/unpacking flake8 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:39:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:39:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:39:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:04 INFO - no previously-included directories found matching 'docs/_build' 09:39:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:39:04 INFO - Running setup.py install for pep8 09:39:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:04 INFO - no previously-included directories found matching 'docs/_build' 09:39:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:39:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:39:04 INFO - Cleaning up... 09:39:04 INFO - Return code: 0 09:39:04 INFO - Running post-action listener: _resource_record_post_action 09:39:04 INFO - Running post-action listener: _start_resource_monitoring 09:39:04 INFO - Starting resource monitoring. 09:39:04 INFO - ##### 09:39:04 INFO - ##### Running install step. 09:39:04 INFO - ##### 09:39:04 INFO - Running pre-action listener: _resource_record_pre_action 09:39:04 INFO - Running main action method: install 09:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:04 INFO - Reading from file tmpfile_stdout 09:39:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:05 INFO - Reading from file tmpfile_stdout 09:39:05 INFO - Output received: 09:39:05 INFO - Usage: mozinstall [options] installer 09:39:05 INFO - Options: 09:39:05 INFO - -h, --help show this help message and exit 09:39:05 INFO - -d DEST, --destination=DEST 09:39:05 INFO - Directory to install application into. [default: 09:39:05 INFO - "/builds/slave/test"] 09:39:05 INFO - --app=APP Application being installed. [default: firefox] 09:39:05 INFO - mkdir: /builds/slave/test/build/application 09:39:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:39:20 INFO - Reading from file tmpfile_stdout 09:39:20 INFO - Output received: 09:39:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:20 INFO - Running post-action listener: _resource_record_post_action 09:39:20 INFO - ##### 09:39:20 INFO - ##### Running run-tests step. 09:39:20 INFO - ##### 09:39:20 INFO - Running pre-action listener: _resource_record_pre_action 09:39:20 INFO - Running main action method: run_tests 09:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:20 INFO - Python 2.7.3 09:39:20 INFO - Return code: 0 09:39:20 INFO - grabbing minidump binary from tooltool 09:39: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')]} 09:39:20 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 0x25a3410>, '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 0x25a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:20 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 09:39:20 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 09:39:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:20 INFO - Return code: 0 09:39:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:39:21 INFO - Return code: 0 09:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 09:39:21 INFO - Using env: {'DISPLAY': ':0', 09:39:21 INFO - 'HOME': '/home/cltbld', 09:39:21 INFO - 'LANG': 'en_US.UTF-8', 09:39:21 INFO - 'LANGUAGE': 'en_US:en', 09:39:21 INFO - 'LOGNAME': 'cltbld', 09:39:21 INFO - 'MAIL': '/var/mail/cltbld', 09:39:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:21 INFO - 'MOZ_NO_REMOTE': '1', 09:39:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:21 INFO - 'NO_EM_RESTART': '1', 09:39:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:21 INFO - 'PWD': '/builds/slave/test', 09:39:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:21 INFO - 'SHELL': '/bin/bash', 09:39:21 INFO - 'SHLVL': '1', 09:39:21 INFO - 'TERM': 'linux', 09:39:21 INFO - 'TMOUT': '86400', 09:39:21 INFO - 'USER': 'cltbld', 09:39:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467', 09:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:21 INFO - '_': '/tools/buildbot/bin/python'} 09:39:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 09:39:21 INFO - mozversion application_buildid: 20160504064752 09:39:21 INFO - mozversion application_changeset: 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 09:39:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:39:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:21 INFO - mozversion application_name: Firefox 09:39:21 INFO - mozversion application_remotingname: firefox-dev 09:39:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:39:21 INFO - mozversion application_vendor: Mozilla 09:39:21 INFO - mozversion application_version: 48.0a2 09:39:21 INFO - mozversion platform_buildid: 20160504064752 09:39:21 INFO - mozversion platform_changeset: 4b9c6eb81f85bc3474a284a831b6ff33344e33a4 09:39:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:39:21 INFO - mozversion platform_version: 48.0a2 09:39:21 INFO - using testdate: 1462379961 09:39:21 INFO - actual date: 1462379961 09:39:21 INFO - starting webserver on 'localhost:36655' 09:39:21 INFO - SUITE-START | Running 2 tests 09:39:21 INFO - TEST-START | dromaeo_css 09:39:21 INFO - operating with platform_type : linux_ 09:39:21 INFO - Initialising browser for dromaeo_css test... 09:39:21 INFO - TEST-INFO | started process 13521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtoz6g/profile http://localhost:36655/getInfo.html) 09:39:26 INFO - PROCESS | 13521 | __metrics Screen width/height:1600/1200 09:39:26 INFO - PROCESS | 13521 | colorDepth:24 09:39:26 INFO - PROCESS | 13521 | Browser inner width/height: 1024/697 09:39:26 INFO - PROCESS | 13521 | __metrics 09:39:27 ERROR - PROCESS | 13521 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:39:28 INFO - TEST-INFO | 13521: exit 0 09:39:28 INFO - Browser initialized. 09:39:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:28 INFO - TEST-INFO | started process 13614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtoz6g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:40 INFO - PROCESS | 13614 | RSS: Main: 142352384 09:39:40 INFO - PROCESS | 13614 | 09:40:31 INFO - PROCESS | 13614 | 1462380031235 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] 09:42:39 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36655/tests/dromaeo/cssquery-ext.html) 09:42:40 INFO - PROCESS | 13614 | RSS: Main: 254906368 09:42:40 INFO - PROCESS | 13614 | 09:45:42 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-ext.html (next: http://localhost:36655/tests/dromaeo/cssquery-jquery.html) 09:45:43 INFO - PROCESS | 13614 | RSS: Main: 229900288 09:45:43 INFO - PROCESS | 13614 | 09:48:44 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36655/tests/dromaeo/cssquery-mootools.html) 09:48:45 INFO - PROCESS | 13614 | RSS: Main: 218767360 09:48:45 INFO - PROCESS | 13614 | 09:51:47 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36655/tests/dromaeo/cssquery-prototype.html) 09:51:48 INFO - PROCESS | 13614 | RSS: Main: 218390528 09:51:48 INFO - PROCESS | 13614 | 09:54:50 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36655/tests/dromaeo/cssquery-yui.html) 09:54:51 INFO - PROCESS | 13614 | RSS: Main: 214642688 09:54:51 INFO - PROCESS | 13614 | 09:57:53 INFO - PROCESS | 13614 | Cycle 1(1): loaded http://localhost:36655/tests/dromaeo/cssquery-yui.html (next: http://localhost:36655/tests/dromaeo/cssquery-dojo.html) 09:57:54 INFO - PROCESS | 13614 | RSS: Main: 261287936 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | __start_tp_report 09:57:54 INFO - PROCESS | 13614 | _x_x_mozilla_page_load 09:57:54 INFO - PROCESS | 13614 | _x_x_mozilla_page_load_details 09:57:54 INFO - PROCESS | 13614 | |i|pagename|runs| 09:57:54 INFO - PROCESS | 13614 | |0;dojo.html;3344.6153692325383;3412.215190506182;3429.1598558353194;3439;3465.9653403465963;5585.8603534911645;5608.971955140224;5626;5630.605857589971;5638.323401191863;5615.691136987464;5634.746436410361;5641.266635337411;5644.209810626516;5646.548276137909;4915.434725006634;5041.924371134436;5080.237964305346;5130.948690513103;5201.985612805504;5051.696898186102;5129.281900533928;5133.281340612317;5133.5636470899835;5133.691978481284;4985.601151907857;5011.924821127686;5043.39479262489;5066.949330506703;5091.567216786559;5154.845354639367;5180.989707007135;5183.87040323993;5191.2472691459525;5203.86990325243;4929.6302777291485;4981.950180498185;5004;5093.745312734349;5117.5650069744115;5439.918401223985;5440.564754819605;5457.045017121988;5466.371367292772;5480.068388373946;5930.406959304079;5936.079907614327;5939.4357536034;5946.881062378771;5966.820995370146;5981.192539007266;6097.69511524422;6113.113598528233;6146.569740118193;6150.846228844314;5632.464915832989;5678.148277758328;5679.914801277984;5680.233168522279;5681.403452637455;5888.587798854039;6105.084237364342;6115.755369785248;6120.724567394478;6137.263528376623;5843.795467158714;5889.823305300848;5902.763889444374;5910.734016969247;5917.970410148007;5898.056310990221;5913.231279933667;5915.260592425947;5916.23088998436;5916.290045194518;5874.647521148745;5893.381194974551;5898.616589921641;5903.822885313448;5916.674582897896;5951.494122999594;5991.760329586855;5995.100734889714;5995.280566332068;6018.097285407136;4566.109608626286;4566.908661826811;4568.406107206109;4568.6116680081905;4598.747068911242;4034.5360283567766;4053.9391909121387;4094.529129150186;4113.8971525711495;4123.9381409278885;5785.27684039495;5787.305523337226;5801.50687191585;5802.158686990363;5809.564282678816;6112.969435152796;6115.327313995457;6121.357257487989;6126.632402055891;6130.969345153335;5573.6098473106495;5707.3721890592005;5739.196512488255;5787.479126878601;5795.072788353843;5129.563987061141;5145.511176438233;5145.562627176732;5146.30524879144;5149.227615857576;6039.973204555148;6229.844253893598;6233.781817636452;6240.500759939194;6243.25080990275;5929.584929055098;5987.5808693391045;6001.699915004145;6002.279726432681;6036;6301.905471417841;6313.1792866928845;6331.3352098029045;6349.7142628580905;6352.872942541216;5785.30576330843;5962.314333851663;5968.343482216866;6018.187544681412;6027.728752206249;6026.186464827368;6069.605475644069;6078.300995385411;6078.878422431615;6116.3272040076445;5800.39095894925;5861.736221870111;5869.559783016376;5873.823785286449;5874.942510348178;5711.314642242957;5744.167095771173;5773.5092517134835;5837.036888913452;5847.152162936435;5790.044642633919;5794.3626201117;5797.362290148165;5798.826035218782;5804.912926306193;5913.2608423947;5929.377415371324;5943.58394912352;5945.464908158287;5946.554008449297;5632.943670563406;5793.971030144822;5819.679917604403;5848.883022339614;5852.561057920758 09:57:54 INFO - PROCESS | 13614 | |1;ext.html;612.9295131059927;666.1872515531052;668.0980676087281;673.4006734006732;749.8087987563171;32554.511682324755;41045.79477102614;41981;42034;42074.789626051825;47437.288440673416;48116.27825582619;48168.27747583789;48237.758811205895;48265;8189.79525511864;8926.46441213526;9243;9243.214326782198;9259.814803703955;10446.738831529234;10672.146228301755;10687.30532515384;10695.83956240657;10705.411202383866;10683.465826708634;10848.945755271212;10849.403282819481;10852.945735271353;10868.184886133571;8106.594670266522;10462.163026957825;10541.262111652188;10670.51982660782;10695.465226738632;10513.894861051369;10699.572017119306;10704.625338113206;10714.892851071545;10720.874308197604;44060.559394405966;45041;45062;45066.77466612679;45282.773586132185;3847.115163512408;3936.980315098435;3989.601039896016;4130.6282434580735;4453.621442177418;34545;35367.802773005096;35504;35583;35772.46341304883;4294.227039132986;4329.652566702546;4334.826606935719;4365.956340436618;4469.240229161051;334027;337767.99999999756;338057;338747;338779;37593.62406375901;38337.616623833965;66206.66896665582;67413.66293168503;67472.3252767466;38690.22619547593;38944.610553894665;39111.41332880009;39113.80443097766;39156.412653810214;17225;17498.212580433912;17504.29982800699;17512.737308940377;17513.12434378276;13296.867031329562;14248;14610.926945365205;14615.269236538343;14685.706285874223;9352.438853668666;9388.295877809192;9414.576344064533;9445.386049906734;9491.620335186515;3624.637536246354;3663.670269675742;3682.392405253157;3688.9262214755554;3698.981505092457;1061.9256652034437;1154.4977934598476;1173.5892437646926;1184.4847491341295;1206.06529939296;34195.487067694005;35417.64582354143;35493.46759798605;35590;35726;1160.5473865192582;1287.2598256002836;1301.316808675434;1309.7184105417382;1318.4792007157312;17955.192016359295;18517.81482185188;18561.90719046396;18584.721229181574;18608.44174674762;542713;549787;549943;551162;551797;63301.68349158225;64062.35937640564;64103.35896640974;64168;64227.67886160633;1406.1563062162825;1435.9876287217696;1461.576142918563;1536.1013806922851;1630.6412589230351;31531.52702709507;33130;33536;33578.66421335755;34140.31719365648;51089.74455127701;51200.74399627978;51581.74209128931;51621;51649;322693;324280;324574;324941;326014;26026;26733.19800405991;28914.855425722737;31100.22249443782;31479.055628331185;45656.31515527336;45669;46027.3095903555;48418;50748.74625626996;41617.58382416137;41874.162516750104;41945.79027104845;42748.145037099704;43788.781056094514;41363.586364137176;42222.1555568893;42588;42657;43325.56674433215;41084.58915410808;41639.7918010408;41846;41887;42580.36129457998;33388;36729;37171.44242836306;37703.62296377001;37847;29230.7076929228;29248.853755731936;29641.703582963895;29878.207307560748;29928.850355748953 09:57:54 INFO - PROCESS | 13614 | |2;jquery.html;438.70825900775986;439.12394772428996;447.8074427995961;448.54472710199155;457.65675743192605;19752;20322.898385508088;20513.17947282107;20532.384028479133;20553.177872885066;18258.45224643263;19772.60454790903;20245.59508809823;20737.170513179455;20804;5996.6402015879075;6122.632642041492;6141.078838174287;6163.753449862;6188.319284878659;4406.162829062484;5996.7301471433675;6123.418275263843;6470.870582588345;6754.45964322853;6696.3638454347;6705.530612857102;6727.899081513781;6732.36042575957;6734.090897728793;6643.468522518187;6686.7993960181275;6720.6639668016405;6728.52900296977;6729.327067293256;4119.443875076856;5790.826275211751;5935.228420305376;6053.697315134225;6062.030075187949;23361.299161025196;23407.88296058526;23548.411289717722;23845.403864903343;23901.760982390126;2546.2743118211406;2803.0189433698247;3159.336539326744;3263.0210936719127;3404.7957122572725;10195.133413659847;10598.947005264925;10620.57517699291;10729.034386905138;14728.852711472855;2014.788447213036;2151.128792838903;2163;2193.6270833958106;2296.70142881426;85574.57212713959;86876.56561717213;88040.5597972006;89637.55181224052;89919;11614.6515604532;11659;11735.530578776754;11823.822642660367;11922.616673314684;16831.242594083295;16975.236114374882;16985.065821379696;16995.23521441538;17013.23440445183;8351.33189344863;8443.408961372645;8609.311255099703;8629.223369896614;8719.12808719123;8141.307988820898;8148.714794982147;8178.550179740171;8272.545010024507;8280.627371768285;4912.901741965141;4958.157113290749;4997.7251251180805;5040.218766091261;5127.41034781005;1880.2009146112848;1926.807319268062;2079.6256673798557;2121.7772133925714;2122.5542636046293;976.7948730766618;1048.09863517375;1063.984040239397;1077.7413420779114;1100.1748688483638;19644.50888727793;19890.403287901387;20299.59400812005;20430.869218461376;20652.483687907923;1078.3857850945276;1108.2353176308322;1110.5058249079082;1179.235887016461;1180.2741314091943;11369.545218191344;11429.371384573762;11513.136514761427;11519.25124866881;11549.942250288696;559744;563022;567259;574634;580082;102382;103323.45014824784;104921;106089.46955265175;106401;1083.3770581915273;1117.5250518529592;1128.4301427779083;1139.9658010259704;1145.66202970124;17746.733798992766;18006.099695014935;18086.5478363042;18171.454856354332;18240.908795455936;40434.39348409835;42304.15391692088;42769.57230427656;42775.71672849819;44255.33616995812;59449.702751485966;60238;61180;61677.69161154165;61887.690561548705;8947.776305592412;8999.55002249898;9226.538673066454;9242.584083716114;9311.534423278945;12210.877891220975;13938.58184254474;14084.507042253472;14255.073420227653;14490.565283041526;9905.959874213391;11425;12096.879031209928;12161.574344897886;12190.390480475764;12122.636320910387;12209.267443953391;12333.506659733868;12616.810747838974;12651.620451386472;12625.242485450903;12872.549460768829;12973.935130324287;13010.414531346301;13173.40719667598;8960.417572857743;8999.64001439935;9274;9283.210927071275;9374.67188648394;8978.685745998859;11718.414079296172;12293.815592766294;12429.627111186679;12502.124851260325 09:57:54 INFO - PROCESS | 13614 | |3;mootools.html;1363.0799210532887;1545.806774153231;1587.9761803572949;1745.7643218165545;1849.8335149836512;8465.830683386328;8797.912020879789;8815.074417186182;8824.338174636896;8832.425892317004;8531.78670533237;8653.783655408617;8713.30293576514;8719.956400218005;8731.257843083346;2178.575177840322;2449.2652204338715;2454.7913427358653;2488.042103790036;2529.127451029401;2501.3371456564023;2518.659980902582;2535.4422027153996;2535.8985640574447;2535.949281014379;2467.3584867934287;2475.665785119013;2475.8638274894874;2476.826622136451;2478.7149477810103;2134.5304033112766;2381.749916258785;2452.9264122076365;2455.8894849731805;2457.5453541094867;2424.7817696407233;2425.1027119965547;2433.5254625348066;2435.622478515833;2454.6072628379375;8623.913760862373;8625.741227763177;8705.303575713928;8722.040575536686;8731.690246463018;5195.7402129893735;5348.064088784447;5354.5180933715765;5360.59795515334;5388.703621300827;3430.2110514581536;3458.56767904012;3549.8225088745717;3618.7105031597407;3630.8547658093644;1147.9368634725088;1157.074340527583;1170.836082948388;1183.1776915044047;1203.506562309449;11883.881161188365;12056.819147712791;12141.817872731915;12142.817857732141;12145;4683.976580117078;4767.785449654774;4843.104025755176;4843.951560484421;4872.6832755870755;10269.332493387907;10314;10338.844917326247;10353.896461035294;10368.637097701545;4959.380077490314;5394.244805727201;5415.323084614423;5433.212184233264;5447.645903016291;4910.90178196434;5016.021875734197;5032.84901452957;5035.043341765127;5052.191649336089;4126.195391898551;4172.3532852407925;4284;4292.248856450109;4426.712263702849;1342.2818791946456;1377.7864431013209;1397.2175581674092;1406.2757679794709;1409.6969151632447;984.0946329376991;1075.306427354352;1091.6943255888364;1093.2565855218527;1103.713034610991;6142.508599312045;6144.324124346318;6329.430351268408;6353.904691429632;6374.681265936684;1027.3219675014454;1047.2512153810062;1061.1192710050639;1066.376169940578;1069.8395240713799;4268.253377959589;4414.161309351213;4438.844640437569;4529.09418116378;4583.679142459996;10680.092192163753;10973.286736362112;11079.612213572647;11178.720531986766;11207.383593902414;10727.463626818628;10802.297850639683;10992.725181870517;11112.22214444981;11118.22172447937;8053.315468185153;8215.630296636666;8230.711925082593;8354.498730076215;8404;5936.851578710394;6130.2030736004035;6154.446099850856;6167.136600875791;6313.273973492924;9765.267604929517;9776.26677999167;9980.950095249767;10025;10182.490875456346;9906.05892440217;9984.650537231162;10058.899411005796;10064.69805905824;10174.847377289494;7292.088488938883;7489.325960663567;7714.3442807362;7720.961395192988;7895.328897043815;8526.275266602408;8539.274161696077;8612.78468038279;8614.526201058752;8616.741497755078;7621.466497345133;7847.882281765892;7883.5664038478435;7888.132305446282;7976.162502937108;7705.884411733717;7753;7769.961150194213;7832.216778322122;7867.09528404218;7099.893501597377;7160.606166660884;7269.127704675473;7316.780496585111;7316.817079573053;5370.194470829407;5514.255575497256;5522.917156242579;5551.861203469945;5706.172604972338;5302.973485132549;5456.154296084113;5584.944150558443;5727.713614319184;5758.3090029196765 09:57:54 INFO - PROCESS | 13614 | |4;prototype.html;348.4198808983043;350.3326163658232;350.79829098268505;367.86389036056653;371.94048952167657;5343.5114503816785;5386.569074474042;5442.2380866678695;5445.319335083114;5478.123500239957;5445.918311225335;5486.753096110675;5487.7530511127;5542.584306177043;5557.638753481031;4100.774457404841;4228.175505776375;4342.565743425664;4369.759663218521;4413.668974826885;4316.726565663122;4347.760873151976;4371.562843715635;4377.102693947733;4378.211921854065;4314.460692413449;4317.244482215599;4325.762083085445;4357.215701173787;4367.759773212472;4096.283150448659;4310.741355518679;4319.114581510783;4389.868303950887;4408.58118478744;3792.7345085844004;3799.5371781863905;3817.9427308590393;3818.522684664417;3823.833730712132;5136.460671629462;5305.204219367087;5327.760250788724;5331.2269720890645;5351.491608297206;4919.188333924898;4924.950750492485;4945;4945.357103576512;4954.60363170949;5756.7985120521;5768.413686236277;5773.191753154561;5792.160136780185;5828.446297601721;4102.979485102555;4187.434696315989;4229;4235.2800023996;4249.766262855542;5821.563382746311;5910.497607703351;5915.467607915265;5932.555058370596;5948.780499997491;4243.596858298457;4297.785110744513;4299.398084268205;4310.676699247506;4316.719413238192;4240.363945408213;4306.720063195882;4350.173467041315;4356;4365.432493775852;4674.205385084544;4924.507549245119;4937.851864444073;4947.925781113287;4948.554630083309;5610.495055444948;5633.915491267634;5636.408177141341;5665.66006039639;5674.687892165888;1554.1995872125865;1575.7006168827886;1577.5346272849538;1582.7388480900752;1591.90448573086;1051.821190397619;1058.2486434631344;1067.743741502034;1080.7460246841986;1081.5511562701547;5972.522198224132;5987.760489580455;6008.128821320884;6026.734385779036;6033.245844269466;6307.148534947723;6333.651649159248;6338.461230795434;6350.523710721714;6367.299597044322;5822.970885145632;5898.318979091025;5925.822225333247;5953.315368732565;5980.970095149496;3352.245744707421;3356.664333566624;3363.64681708422;3384.4077286474767;3387.81367024816;5900.498457631149;6188.81433556994;6199;6506.577072490273;6544.181977252843;5971.373005834412;6027.523256802024;6039.275286965504;6042.818715438544;6069.575129740876;5945.346011938596;6224.253089629183;6231.105559025609;6231.376862313732;6267.370483674277;5966.940330596639;5976.551758618208;5988.28140623128;6002.349353927705;6049.304330002106;5930.8220753375745;5930.851728706644;5956.166136740946;5968.552358573038;5973.611715238496;5877.500412464818;6197.442230199304;6221;6228.439440450381;6238.625682459067;4290.056187638715;4344.717593356421;4370.868873933787;4372.982641977026;4382.189294980439;5603.243562119062;5719.542436604978;5986.682929755447;6070.878582428415;6081.756729730761;5812;5813.883722325614;5851.327097383855;5862.413758624274;5863.501602363676;5787.131930210334;5794.275715535558;5820.505257053029;5821.650700957956;5863.237779088691;5435.592330575302;5641.182028605911;5680.943190568041;5721.885562288814;5754.395788442153;5794.971025144847;5814.418558144152;5860.443257890493;5862.501687356452;5908.675022873611;5549.916751248654;5721.628094173865;5725.398833122462;5745.6552606843725;5749.223854779719 09:57:54 INFO - PROCESS | 13614 | |5;yui.html;859.9699010534632;897.48394673063;909.2680392284211;925.8379783537879;936.0499093420179;15891.125988070666;16045.358185672574;16100.194990250498;17454.91272543639;18092.185851636674;16658.916705416486;16688.33246670132;16777.161141942914;16834.158292085376;16863.07253101082;737.9372753315974;887.1926546842375;901.8286525560155;913.8355096082703;914.5655813488606;908.3459908865606;909.9454032758023;911.6854685133618;913.0458670689112;913.4701872913728;956.4261443134098;963.7012526116927;965.0783501755807;965.1024547171128;965.5461932891565;768.2816566510303;909.3498148823622;934.6308208257768;957.1624828275259;958.0467434902282;680.8263892707328;683.2211279141783;684.3191024930177;684.4114061906756;684.8972654101875;15701.057936523845;15709.685806283924;15730.842691573167;15736.055836649723;15785.842141578552;14306.28468576567;14634.682878540982;14687.77968330476;14688;14815.925920370437;12236.327002014885;12360.752784944341;12412.75174496514;12415.93792031034;12663.430145643468;4039.596040395966;4041.9191616167805;4058.5738497457933;4130.339145736668;4173.624373806372;58562.41437585612;58589.99999999957;58801.7059914702;58863.70568147132;59005.704971474865;11438.142139339416;11525;11714.824277635842;11797.056235501312;11831.349275789915;21146.577068458544;21480.570388592452;21486.677699834516;21496.89251553732;21543.13827446916;8981.371304008788;9096.226820720312;9178.93106119291;9188.954055229815;9311.255099592152;5279.709615971158;5341.62608617393;5364.356277246756;5406.54044406222;5410.08028635133;3666.7983260920373;3771.981140094282;3791.431285307226;3801.163743976321;3803.353429916921;710.261698791662;711.8896571031395;712.4407340237889;719.5898337947424;721.5526373648266;667.4726965697045;760.5702777930452;761.4251240313528;774.2953911940108;809.0978558906894;10364.5335959882;10368.22238332113;10371.844422333672;10432.895671043345;10543.156547476183;837.8282452097305;838.4759525296689;840.5293035899793;857.5412154497438;866.5234121233296;4625.699329543569;4641.164590373698;4659.301104834234;4671.649626278043;4701.929471057937;61990.69004654948;62604.373956260766;65241.673791631685;66715.66642166855;67029.32970670328;55010.44989550133;56153.71923140358;57320.14019789623;59058.40941590615;59901;48063.279050814264;50181;53895.19157212645;54061.459385405644;56524.71737641285;9615.56729947168;9729.444344828813;9923.156531694887;9993.250506211918;10300.948495257475;32368;35924.4611330825;36321.27357452889;36345.27309453849;37202;46402.30396543987;47493.287600685326;47929.52070479251;49142.75428622834;49280.75359623179;13280;13321.53374631922;13525.120867143603;13629.86370136286;13791.10357826738;14075.507357242448;15060.623484412978;15215;15539.13530376362;15704.685906282039;12925;13414.216428468646;13514.391852366864;14307.92846035763;14568.781468278195;13476.326183690971;13903.721925561229;14155.716885662023;14159.150450972975;14190.574282771533;13852.052165132889;14094.929525352718;14230.857691422952;14335.426582936983;14427.49503767363;11766.235194712317;11833.644990650295;11951.402429878644;12161.39193040362;12181.08641851847;11184.384858832842;11291.322520648788;11627.883721163018;11648;11655.59205427806 09:57:54 INFO - PROCESS | 13614 | __end_tp_report 09:57:54 INFO - PROCESS | 13614 | __start_cc_report 09:57:54 INFO - PROCESS | 13614 | _x_x_mozilla_cycle_collect,876 09:57:54 INFO - PROCESS | 13614 | __end_cc_report 09:57:54 INFO - PROCESS | 13614 | __startTimestamp1462381074124__endTimestamp 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | ------- Summary: start ------- 09:57:54 INFO - PROCESS | 13614 | Number of tests: 6 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#0] dojo.html Cycles:165 Average:5581.60 Median:5800.39 stddev:623.47 (10.7%) stddev-sans-first:600.18 09:57:54 INFO - PROCESS | 13614 | Values: 3344.6 3412.2 3429.2 3439.0 3466.0 5585.9 5609.0 5626.0 5630.6 5638.3 5615.7 5634.7 5641.3 5644.2 5646.5 4915.4 5041.9 5080.2 5130.9 5202.0 5051.7 5129.3 5133.3 5133.6 5133.7 4985.6 5011.9 5043.4 5066.9 5091.6 5154.8 5181.0 5183.9 5191.2 5203.9 4929.6 4982.0 5004.0 5093.7 5117.6 5439.9 5440.6 5457.0 5466.4 5480.1 5930.4 5936.1 5939.4 5946.9 5966.8 5981.2 6097.7 6113.1 6146.6 6150.8 5632.5 5678.1 5679.9 5680.2 5681.4 5888.6 6105.1 6115.8 6120.7 6137.3 5843.8 5889.8 5902.8 5910.7 5918.0 5898.1 5913.2 5915.3 5916.2 5916.3 5874.6 5893.4 5898.6 5903.8 5916.7 5951.5 5991.8 5995.1 5995.3 6018.1 4566.1 4566.9 4568.4 4568.6 4598.7 4034.5 4053.9 4094.5 4113.9 4123.9 5785.3 5787.3 5801.5 5802.2 5809.6 6113.0 6115.3 6121.4 6126.6 6131.0 5573.6 5707.4 5739.2 5787.5 5795.1 5129.6 5145.5 5145.6 5146.3 5149.2 6040.0 6229.8 6233.8 6240.5 6243.3 5929.6 5987.6 6001.7 6002.3 6036.0 6301.9 6313.2 6331.3 6349.7 6352.9 5785.3 5962.3 5968.3 6018.2 6027.7 6026.2 6069.6 6078.3 6078.9 6116.3 5800.4 5861.7 5869.6 5873.8 5874.9 5711.3 5744.2 5773.5 5837.0 5847.2 5790.0 5794.4 5797.4 5798.8 5804.9 5913.3 5929.4 5943.6 5945.5 5946.6 5632.9 5794.0 5819.7 5848.9 5852.6 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#1] ext.html Cycles:180 Average:57056.21 Median:3693.95 stddev:110449.06 (2990.0%) stddev-sans-first:110677.60 09:57:54 INFO - PROCESS | 13614 | Values: 612.9 666.2 668.1 673.4 749.8 32554.5 41045.8 41981.0 42034.0 42074.8 47437.3 48116.3 48168.3 48237.8 48265.0 8189.8 8926.5 9243.0 9243.2 9259.8 10446.7 10672.1 10687.3 10695.8 10705.4 10683.5 10848.9 10849.4 10852.9 10868.2 8106.6 10462.2 10541.3 10670.5 10695.5 10513.9 10699.6 10704.6 10714.9 10720.9 44060.6 45041.0 45062.0 45066.8 45282.8 3847.1 3937.0 3989.6 4130.6 4453.6 34545.0 35367.8 35504.0 35583.0 35772.5 4294.2 4329.7 4334.8 4366.0 4469.2 334027.0 337768.0 338057.0 338747.0 338779.0 37593.6 38337.6 66206.7 67413.7 67472.3 38690.2 38944.6 39111.4 39113.8 39156.4 17225.0 17498.2 17504.3 17512.7 17513.1 13296.9 14248.0 14610.9 14615.3 14685.7 9352.4 9388.3 9414.6 9445.4 9491.6 3624.6 3663.7 3682.4 3688.9 3699.0 1061.9 1154.5 1173.6 1184.5 1206.1 34195.5 35417.6 35493.5 35590.0 35726.0 1160.5 1287.3 1301.3 1309.7 1318.5 17955.2 18517.8 18561.9 18584.7 18608.4 542713.0 549787.0 549943.0 551162.0 551797.0 63301.7 64062.4 64103.4 64168.0 64227.7 1406.2 1436.0 1461.6 1536.1 1630.6 31531.5 33130.0 33536.0 33578.7 34140.3 51089.7 51200.7 51581.7 51621.0 51649.0 322693.0 324280.0 324574.0 324941.0 326014.0 26026.0 26733.2 28914.9 31100.2 31479.1 45656.3 45669.0 46027.3 48418.0 50748.7 41617.6 41874.2 41945.8 42748.1 43788.8 41363.6 42222.2 42588.0 42657.0 43325.6 41084.6 41639.8 41846.0 41887.0 42580.4 33388.0 36729.0 37171.4 37703.6 37847.0 29230.7 29248.9 29641.7 29878.2 29928.9 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#2] jquery.html Cycles:180 Average:32308.02 Median:2245.16 stddev:93730.96 (4174.8%) stddev-sans-first:93963.35 09:57:54 INFO - PROCESS | 13614 | Values: 438.7 439.1 447.8 448.5 457.7 19752.0 20322.9 20513.2 20532.4 20553.2 18258.5 19772.6 20245.6 20737.2 20804.0 5996.6 6122.6 6141.1 6163.8 6188.3 4406.2 5996.7 6123.4 6470.9 6754.5 6696.4 6705.5 6727.9 6732.4 6734.1 6643.5 6686.8 6720.7 6728.5 6729.3 4119.4 5790.8 5935.2 6053.7 6062.0 23361.3 23407.9 23548.4 23845.4 23901.8 2546.3 2803.0 3159.3 3263.0 3404.8 10195.1 10598.9 10620.6 10729.0 14728.9 2014.8 2151.1 2163.0 2193.6 2296.7 85574.6 86876.6 88040.6 89637.6 89919.0 11614.7 11659.0 11735.5 11823.8 11922.6 16831.2 16975.2 16985.1 16995.2 17013.2 8351.3 8443.4 8609.3 8629.2 8719.1 8141.3 8148.7 8178.6 8272.5 8280.6 4912.9 4958.2 4997.7 5040.2 5127.4 1880.2 1926.8 2079.6 2121.8 2122.6 976.8 1048.1 1064.0 1077.7 1100.2 19644.5 19890.4 20299.6 20430.9 20652.5 1078.4 1108.2 1110.5 1179.2 1180.3 11369.5 11429.4 11513.1 11519.3 11549.9 559744.0 563022.0 567259.0 574634.0 580082.0 102382.0 103323.5 104921.0 106089.5 106401.0 1083.4 1117.5 1128.4 1140.0 1145.7 17746.7 18006.1 18086.5 18171.5 18240.9 40434.4 42304.2 42769.6 42775.7 44255.3 59449.7 60238.0 61180.0 61677.7 61887.7 8947.8 8999.6 9226.5 9242.6 9311.5 12210.9 13938.6 14084.5 14255.1 14490.6 9906.0 11425.0 12096.9 12161.6 12190.4 12122.6 12209.3 12333.5 12616.8 12651.6 12625.2 12872.5 12973.9 13010.4 13173.4 8960.4 8999.6 9274.0 9283.2 9374.7 8978.7 11718.4 12293.8 12429.6 12502.1 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#3] mootools.html Cycles:180 Average:5903.76 Median:4805.44 stddev:3226.60 (67.1%) stddev-sans-first:3217.60 09:57:54 INFO - PROCESS | 13614 | Values: 1363.1 1545.8 1588.0 1745.8 1849.8 8465.8 8797.9 8815.1 8824.3 8832.4 8531.8 8653.8 8713.3 8720.0 8731.3 2178.6 2449.3 2454.8 2488.0 2529.1 2501.3 2518.7 2535.4 2535.9 2535.9 2467.4 2475.7 2475.9 2476.8 2478.7 2134.5 2381.7 2452.9 2455.9 2457.5 2424.8 2425.1 2433.5 2435.6 2454.6 8623.9 8625.7 8705.3 8722.0 8731.7 5195.7 5348.1 5354.5 5360.6 5388.7 3430.2 3458.6 3549.8 3618.7 3630.9 1147.9 1157.1 1170.8 1183.2 1203.5 11883.9 12056.8 12141.8 12142.8 12145.0 4684.0 4767.8 4843.1 4844.0 4872.7 10269.3 10314.0 10338.8 10353.9 10368.6 4959.4 5394.2 5415.3 5433.2 5447.6 4910.9 5016.0 5032.8 5035.0 5052.2 4126.2 4172.4 4284.0 4292.2 4426.7 1342.3 1377.8 1397.2 1406.3 1409.7 984.1 1075.3 1091.7 1093.3 1103.7 6142.5 6144.3 6329.4 6353.9 6374.7 1027.3 1047.3 1061.1 1066.4 1069.8 4268.3 4414.2 4438.8 4529.1 4583.7 10680.1 10973.3 11079.6 11178.7 11207.4 10727.5 10802.3 10992.7 11112.2 11118.2 8053.3 8215.6 8230.7 8354.5 8404.0 5936.9 6130.2 6154.4 6167.1 6313.3 9765.3 9776.3 9981.0 10025.0 10182.5 9906.1 9984.7 10058.9 10064.7 10174.8 7292.1 7489.3 7714.3 7721.0 7895.3 8526.3 8539.3 8612.8 8614.5 8616.7 7621.5 7847.9 7883.6 7888.1 7976.2 7705.9 7753.0 7770.0 7832.2 7867.1 7099.9 7160.6 7269.1 7316.8 7316.8 5370.2 5514.3 5522.9 5551.9 5706.2 5303.0 5456.2 5584.9 5727.7 5758.3 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#4] prototype.html Cycles:180 Average:4933.31 Median:5553.78 stddev:1435.99 (25.9%) stddev-sans-first:1398.18 09:57:54 INFO - PROCESS | 13614 | Values: 348.4 350.3 350.8 367.9 371.9 5343.5 5386.6 5442.2 5445.3 5478.1 5445.9 5486.8 5487.8 5542.6 5557.6 4100.8 4228.2 4342.6 4369.8 4413.7 4316.7 4347.8 4371.6 4377.1 4378.2 4314.5 4317.2 4325.8 4357.2 4367.8 4096.3 4310.7 4319.1 4389.9 4408.6 3792.7 3799.5 3817.9 3818.5 3823.8 5136.5 5305.2 5327.8 5331.2 5351.5 4919.2 4925.0 4945.0 4945.4 4954.6 5756.8 5768.4 5773.2 5792.2 5828.4 4103.0 4187.4 4229.0 4235.3 4249.8 5821.6 5910.5 5915.5 5932.6 5948.8 4243.6 4297.8 4299.4 4310.7 4316.7 4240.4 4306.7 4350.2 4356.0 4365.4 4674.2 4924.5 4937.9 4947.9 4948.6 5610.5 5633.9 5636.4 5665.7 5674.7 1554.2 1575.7 1577.5 1582.7 1591.9 1051.8 1058.2 1067.7 1080.7 1081.6 5972.5 5987.8 6008.1 6026.7 6033.2 6307.1 6333.7 6338.5 6350.5 6367.3 5823.0 5898.3 5925.8 5953.3 5981.0 3352.2 3356.7 3363.6 3384.4 3387.8 5900.5 6188.8 6199.0 6506.6 6544.2 5971.4 6027.5 6039.3 6042.8 6069.6 5945.3 6224.3 6231.1 6231.4 6267.4 5966.9 5976.6 5988.3 6002.3 6049.3 5930.8 5930.9 5956.2 5968.6 5973.6 5877.5 6197.4 6221.0 6228.4 6238.6 4290.1 4344.7 4370.9 4373.0 4382.2 5603.2 5719.5 5986.7 6070.9 6081.8 5812.0 5813.9 5851.3 5862.4 5863.5 5787.1 5794.3 5820.5 5821.7 5863.2 5435.6 5641.2 5680.9 5721.9 5754.4 5795.0 5814.4 5860.4 5862.5 5908.7 5549.9 5721.6 5725.4 5745.7 5749.2 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - PROCESS | 13614 | [#5] yui.html Cycles:180 Average:15985.04 Median:4399.66 stddev:17947.32 (407.9%) stddev-sans-first:17961.72 09:57:54 INFO - PROCESS | 13614 | Values: 860.0 897.5 909.3 925.8 936.0 15891.1 16045.4 16100.2 17454.9 18092.2 16658.9 16688.3 16777.2 16834.2 16863.1 737.9 887.2 901.8 913.8 914.6 908.3 909.9 911.7 913.0 913.5 956.4 963.7 965.1 965.1 965.5 768.3 909.3 934.6 957.2 958.0 680.8 683.2 684.3 684.4 684.9 15701.1 15709.7 15730.8 15736.1 15785.8 14306.3 14634.7 14687.8 14688.0 14815.9 12236.3 12360.8 12412.8 12415.9 12663.4 4039.6 4041.9 4058.6 4130.3 4173.6 58562.4 58590.0 58801.7 58863.7 59005.7 11438.1 11525.0 11714.8 11797.1 11831.3 21146.6 21480.6 21486.7 21496.9 21543.1 8981.4 9096.2 9178.9 9189.0 9311.3 5279.7 5341.6 5364.4 5406.5 5410.1 3666.8 3772.0 3791.4 3801.2 3803.4 710.3 711.9 712.4 719.6 721.6 667.5 760.6 761.4 774.3 809.1 10364.5 10368.2 10371.8 10432.9 10543.2 837.8 838.5 840.5 857.5 866.5 4625.7 4641.2 4659.3 4671.6 4701.9 61990.7 62604.4 65241.7 66715.7 67029.3 55010.4 56153.7 57320.1 59058.4 59901.0 48063.3 50181.0 53895.2 54061.5 56524.7 9615.6 9729.4 9923.2 9993.3 10300.9 32368.0 35924.5 36321.3 36345.3 37202.0 46402.3 47493.3 47929.5 49142.8 49280.8 13280.0 13321.5 13525.1 13629.9 13791.1 14075.5 15060.6 15215.0 15539.1 15704.7 12925.0 13414.2 13514.4 14307.9 14568.8 13476.3 13903.7 14155.7 14159.2 14190.6 13852.1 14094.9 14230.9 14335.4 14427.5 11766.2 11833.6 11951.4 12161.4 12181.1 11184.4 11291.3 11627.9 11648.0 11655.6 09:57:54 INFO - PROCESS | 13614 | -------- Summary: end -------- 09:57:54 INFO - PROCESS | 13614 | 09:57:54 INFO - TEST-INFO | 13614: exit 0 09:57:54 INFO - TEST-OK | dromaeo_css | took 1113052ms 09:57:54 INFO - TEST-START | kraken 09:57:54 INFO - operating with platform_type : linux_ 09:57:54 INFO - Initialising browser for kraken test... 09:57:54 INFO - TEST-INFO | started process 13800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMcEZWz/profile http://localhost:36655/getInfo.html) 09:57:59 INFO - PROCESS | 13800 | __metrics Screen width/height:1600/1200 09:57:59 INFO - PROCESS | 13800 | colorDepth:24 09:57:59 INFO - PROCESS | 13800 | Browser inner width/height: 1024/697 09:57:59 INFO - PROCESS | 13800 | __metrics 09:58:00 ERROR - PROCESS | 13800 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:58:01 INFO - TEST-INFO | 13800: exit 0 09:58:01 INFO - Browser initialized. 09:58:01 INFO - Running cycle 1/1 for kraken test... 09:58:01 INFO - TEST-INFO | started process 13892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMcEZWz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:13 INFO - PROCESS | 13892 | RSS: Main: 142598144 09:58:13 INFO - PROCESS | 13892 | 09:58:15 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36655/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:16 INFO - PROCESS | 13892 | RSS: Main: 190906368 09:58:16 INFO - PROCESS | 13892 | 09:58:18 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36655/tests/kraken/driver.html?testName=audio-dft) 09:58:19 INFO - PROCESS | 13892 | RSS: Main: 184578048 09:58:19 INFO - PROCESS | 13892 | 09:58:22 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36655/tests/kraken/driver.html?testName=audio-fft) 09:58:22 INFO - PROCESS | 13892 | RSS: Main: 272883712 09:58:22 INFO - PROCESS | 13892 | 09:58:25 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36655/tests/kraken/driver.html?testName=audio-oscillator) 09:58:25 INFO - PROCESS | 13892 | RSS: Main: 182587392 09:58:25 INFO - PROCESS | 13892 | 09:58:27 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:28 INFO - PROCESS | 13892 | RSS: Main: 181751808 09:58:28 INFO - PROCESS | 13892 | 09:58:31 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36655/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:32 INFO - PROCESS | 13892 | RSS: Main: 215654400 09:58:32 INFO - PROCESS | 13892 | 09:58:35 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36655/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:35 INFO - PROCESS | 13892 | RSS: Main: 215597056 09:58:35 INFO - PROCESS | 13892 | 09:58:38 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36655/tests/kraken/driver.html?testName=json-parse-financial) 09:58:39 INFO - PROCESS | 13892 | RSS: Main: 215482368 09:58:39 INFO - PROCESS | 13892 | 09:58:40 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:41 INFO - PROCESS | 13892 | RSS: Main: 197804032 09:58:41 INFO - PROCESS | 13892 | 09:58:43 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:43 INFO - PROCESS | 13892 | RSS: Main: 195321856 09:58:43 INFO - PROCESS | 13892 | 09:58:45 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:58:46 INFO - PROCESS | 13892 | RSS: Main: 207904768 09:58:46 INFO - PROCESS | 13892 | 09:58:48 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:58:49 INFO - PROCESS | 13892 | RSS: Main: 216440832 09:58:49 INFO - PROCESS | 13892 | 09:58:52 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:58:52 INFO - PROCESS | 13892 | RSS: Main: 213155840 09:58:52 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | Cycle 1(1): loaded http://localhost:36655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36655/tests/kraken/driver.html?testName=ai-astar) 09:58:54 INFO - PROCESS | 13892 | RSS: Main: 276844544 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | __start_tp_report 09:58:54 INFO - PROCESS | 13892 | _x_x_mozilla_page_load 09:58:54 INFO - PROCESS | 13892 | _x_x_mozilla_page_load_details 09:58:54 INFO - PROCESS | 13892 | |i|pagename|runs| 09:58:54 INFO - PROCESS | 13892 | |0;ai-astar;110;110;105;108;110;111;99;110;109;109 09:58:54 INFO - PROCESS | 13892 | |1;audio-beat-detection;157;135;158;171;135;171;151;132;182;126 09:58:54 INFO - PROCESS | 13892 | |2;audio-dft;162;162;160;160;160;161;160;170;161;163 09:58:54 INFO - PROCESS | 13892 | |3;audio-fft;76;77;76;175;77;75;76;76;166;77 09:58:54 INFO - PROCESS | 13892 | |4;audio-oscillator;91;92;159;92;92;92;154;92;92;151 09:58:54 INFO - PROCESS | 13892 | |5;imaging-gaussian-blur;116;116;117;117;117;116;116;116;116;117 09:58:54 INFO - PROCESS | 13892 | |6;imaging-darkroom;146;145;145;145;145;145;145;146;145;145 09:58:54 INFO - PROCESS | 13892 | |7;imaging-desaturate;95;94;94;95;95;95;95;94;95;94 09:58:54 INFO - PROCESS | 13892 | |8;json-parse-financial;53;55;55;56;56;57;55;73;55;60 09:58:54 INFO - PROCESS | 13892 | |9;json-stringify-tinderbox;58;56;56;56;57;56;57;57;57;57 09:58:54 INFO - PROCESS | 13892 | |10;stanford-crypto-aes;71;72;81;76;75;72;73;72;72;72 09:58:54 INFO - PROCESS | 13892 | |11;stanford-crypto-ccm;119;126;117;120;119;116;116;119;157;123 09:58:54 INFO - PROCESS | 13892 | |12;stanford-crypto-pbkdf2;159;159;158;162;160;162;156;164;165;161 09:58:54 INFO - PROCESS | 13892 | |13;stanford-crypto-sha256-iterative;67;68;69;66;66;67;68;67;67;66 09:58:54 INFO - PROCESS | 13892 | __end_tp_report 09:58:54 INFO - PROCESS | 13892 | __start_cc_report 09:58:54 INFO - PROCESS | 13892 | _x_x_mozilla_cycle_collect,1590 09:58:54 INFO - PROCESS | 13892 | __end_cc_report 09:58:54 INFO - PROCESS | 13892 | __startTimestamp1462381134547__endTimestamp 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | ------- Summary: start ------- 09:58:54 INFO - PROCESS | 13892 | Number of tests: 14 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#0] ai-astar Cycles:10 Average:108.10 Median:110.00 stddev:3.60 (3.3%) stddev-sans-first:3.76 09:58:54 INFO - PROCESS | 13892 | Values: 110.0 110.0 105.0 108.0 110.0 111.0 99.0 110.0 109.0 109.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:157.50 stddev:19.26 (12.2%) stddev-sans-first:20.33 09:58:54 INFO - PROCESS | 13892 | Values: 157.0 135.0 158.0 171.0 135.0 171.0 151.0 132.0 182.0 126.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:3.03 (1.9%) stddev-sans-first:3.22 09:58:54 INFO - PROCESS | 13892 | Values: 162.0 162.0 160.0 160.0 160.0 161.0 160.0 170.0 161.0 163.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:39.80 (52.4%) stddev-sans-first:41.61 09:58:54 INFO - PROCESS | 13892 | Values: 76.0 77.0 76.0 175.0 77.0 75.0 76.0 76.0 166.0 77.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.00 stddev:30.40 (33.0%) stddev-sans-first:31.40 09:58:54 INFO - PROCESS | 13892 | Values: 91.0 92.0 159.0 92.0 92.0 92.0 154.0 92.0 92.0 151.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:58:54 INFO - PROCESS | 13892 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 09:58:54 INFO - PROCESS | 13892 | Values: 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:58:54 INFO - PROCESS | 13892 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.00 stddev:5.74 (10.2%) stddev-sans-first:5.85 09:58:54 INFO - PROCESS | 13892 | Values: 53.0 55.0 55.0 56.0 56.0 57.0 55.0 73.0 55.0 60.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.53 09:58:54 INFO - PROCESS | 13892 | Values: 58.0 56.0 56.0 56.0 57.0 56.0 57.0 57.0 57.0 57.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:72.50 stddev:3.03 (4.2%) stddev-sans-first:3.06 09:58:54 INFO - PROCESS | 13892 | Values: 71.0 72.0 81.0 76.0 75.0 72.0 73.0 72.0 72.0 72.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:119.50 stddev:12.27 (10.3%) stddev-sans-first:12.92 09:58:54 INFO - PROCESS | 13892 | Values: 119.0 126.0 117.0 120.0 119.0 116.0 116.0 119.0 157.0 123.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.50 stddev:2.76 (1.7%) stddev-sans-first:2.86 09:58:54 INFO - PROCESS | 13892 | Values: 159.0 159.0 158.0 162.0 160.0 162.0 156.0 164.0 165.0 161.0 09:58:54 INFO - PROCESS | 13892 | 09:58:54 INFO - PROCESS | 13892 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 09:58:54 INFO - PROCESS | 13892 | Values: 67.0 68.0 69.0 66.0 66.0 67.0 68.0 67.0 67.0 66.0 09:58:54 INFO - PROCESS | 13892 | -------- Summary: end -------- 09:58:54 INFO - PROCESS | 13892 | 09:58:55 INFO - TEST-INFO | 13892: exit 0 09:58:55 INFO - TEST-OK | kraken | took 60519ms 09:58:55 INFO - SUITE-END | took 1173s 09:58:55 INFO - Completed test suite (00:19:33) 09:58:55 INFO - javascript benchmark 09:58:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.6153692325383, 3412.215190506182, 3429.1598558353194, 3439.0, 3465.9653403465963, 5585.8603534911645, 5608.971955140224, 5626.0, 5630.605857589971, 5638.323401191863, 5615.691136987464, 5634.746436410361, 5641.266635337411, 5644.209810626516, 5646.548276137909, 4915.434725006634, 5041.924371134436, 5080.237964305346, 5130.948690513103, 5201.985612805504, 5051.696898186102, 5129.281900533928, 5133.281340612317, 5133.5636470899835, 5133.691978481284, 4985.601151907857, 5011.924821127686, 5043.39479262489, 5066.949330506703, 5091.567216786559, 5154.845354639367, 5180.989707007135, 5183.87040323993, 5191.2472691459525, 5203.86990325243, 4929.6302777291485, 4981.950180498185, 5004.0, 5093.745312734349, 5117.5650069744115, 5439.918401223985, 5440.564754819605, 5457.045017121988, 5466.371367292772, 5480.068388373946, 5930.406959304079, 5936.079907614327, 5939.4357536034, 5946.881062378771, 5966.820995370146, 5981.192539007266, 6097.69511524422, 6113.113598528233, 6146.569740118193, 6150.846228844314, 5632.464915832989, 5678.148277758328, 5679.914801277984, 5680.233168522279, 5681.403452637455, 5888.587798854039, 6105.084237364342, 6115.755369785248, 6120.724567394478, 6137.263528376623, 5843.795467158714, 5889.823305300848, 5902.763889444374, 5910.734016969247, 5917.970410148007, 5898.056310990221, 5913.231279933667, 5915.260592425947, 5916.23088998436, 5916.290045194518, 5874.647521148745, 5893.381194974551, 5898.616589921641, 5903.822885313448, 5916.674582897896, 5951.494122999594, 5991.760329586855, 5995.100734889714, 5995.280566332068, 6018.097285407136, 4566.109608626286, 4566.908661826811, 4568.406107206109, 4568.6116680081905, 4598.747068911242, 4034.5360283567766, 4053.9391909121387, 4094.529129150186, 4113.8971525711495, 4123.9381409278885, 5785.27684039495, 5787.305523337226, 5801.50687191585, 5802.158686990363, 5809.564282678816, 6112.969435152796, 6115.327313995457, 6121.357257487989, 6126.632402055891, 6130.969345153335, 5573.6098473106495, 5707.3721890592005, 5739.196512488255, 5787.479126878601, 5795.072788353843, 5129.563987061141, 5145.511176438233, 5145.562627176732, 5146.30524879144, 5149.227615857576, 6039.973204555148, 6229.844253893598, 6233.781817636452, 6240.500759939194, 6243.25080990275, 5929.584929055098, 5987.5808693391045, 6001.699915004145, 6002.279726432681, 6036.0, 6301.905471417841, 6313.1792866928845, 6331.3352098029045, 6349.7142628580905, 6352.872942541216, 5785.30576330843, 5962.314333851663, 5968.343482216866, 6018.187544681412, 6027.728752206249, 6026.186464827368, 6069.605475644069, 6078.300995385411, 6078.878422431615, 6116.3272040076445, 5800.39095894925, 5861.736221870111, 5869.559783016376, 5873.823785286449, 5874.942510348178, 5711.314642242957, 5744.167095771173, 5773.5092517134835, 5837.036888913452, 5847.152162936435, 5790.044642633919, 5794.3626201117, 5797.362290148165, 5798.826035218782, 5804.912926306193, 5913.2608423947, 5929.377415371324, 5943.58394912352, 5945.464908158287, 5946.554008449297, 5632.943670563406, 5793.971030144822, 5819.679917604403, 5848.883022339614, 5852.561057920758], "value": 5541.14304066019, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.9295131059927, 666.1872515531052, 668.0980676087281, 673.4006734006732, 749.8087987563171, 32554.511682324755, 41045.79477102614, 41981.0, 42034.0, 42074.789626051825, 47437.288440673416, 48116.27825582619, 48168.27747583789, 48237.758811205895, 48265.0, 8189.79525511864, 8926.46441213526, 9243.0, 9243.214326782198, 9259.814803703955, 10446.738831529234, 10672.146228301755, 10687.30532515384, 10695.83956240657, 10705.411202383866, 10683.465826708634, 10848.945755271212, 10849.403282819481, 10852.945735271353, 10868.184886133571, 8106.594670266522, 10462.163026957825, 10541.262111652188, 10670.51982660782, 10695.465226738632, 10513.894861051369, 10699.572017119306, 10704.625338113206, 10714.892851071545, 10720.874308197604, 44060.559394405966, 45041.0, 45062.0, 45066.77466612679, 45282.773586132185, 3847.115163512408, 3936.980315098435, 3989.601039896016, 4130.6282434580735, 4453.621442177418, 34545.0, 35367.802773005096, 35504.0, 35583.0, 35772.46341304883, 4294.227039132986, 4329.652566702546, 4334.826606935719, 4365.956340436618, 4469.240229161051, 334027.0, 337767.99999999756, 338057.0, 338747.0, 338779.0, 37593.62406375901, 38337.616623833965, 66206.66896665582, 67413.66293168503, 67472.3252767466, 38690.22619547593, 38944.610553894665, 39111.41332880009, 39113.80443097766, 39156.412653810214, 17225.0, 17498.212580433912, 17504.29982800699, 17512.737308940377, 17513.12434378276, 13296.867031329562, 14248.0, 14610.926945365205, 14615.269236538343, 14685.706285874223, 9352.438853668666, 9388.295877809192, 9414.576344064533, 9445.386049906734, 9491.620335186515, 3624.637536246354, 3663.670269675742, 3682.392405253157, 3688.9262214755554, 3698.981505092457, 1061.9256652034437, 1154.4977934598476, 1173.5892437646926, 1184.4847491341295, 1206.06529939296, 34195.487067694005, 35417.64582354143, 35493.46759798605, 35590.0, 35726.0, 1160.5473865192582, 1287.2598256002836, 1301.316808675434, 1309.7184105417382, 1318.4792007157312, 17955.192016359295, 18517.81482185188, 18561.90719046396, 18584.721229181574, 18608.44174674762, 542713.0, 549787.0, 549943.0, 551162.0, 551797.0, 63301.68349158225, 64062.35937640564, 64103.35896640974, 64168.0, 64227.67886160633, 1406.1563062162825, 1435.9876287217696, 1461.576142918563, 1536.1013806922851, 1630.6412589230351, 31531.52702709507, 33130.0, 33536.0, 33578.66421335755, 34140.31719365648, 51089.74455127701, 51200.74399627978, 51581.74209128931, 51621.0, 51649.0, 322693.0, 324280.0, 324574.0, 324941.0, 326014.0, 26026.0, 26733.19800405991, 28914.855425722737, 31100.22249443782, 31479.055628331185, 45656.31515527336, 45669.0, 46027.3095903555, 48418.0, 50748.74625626996, 41617.58382416137, 41874.162516750104, 41945.79027104845, 42748.145037099704, 43788.781056094514, 41363.586364137176, 42222.1555568893, 42588.0, 42657.0, 43325.56674433215, 41084.58915410808, 41639.7918010408, 41846.0, 41887.0, 42580.36129457998, 33388.0, 36729.0, 37171.44242836306, 37703.62296377001, 37847.0, 29230.7076929228, 29248.853755731936, 29641.703582963895, 29878.207307560748, 29928.850355748953], "value": 20079.872835735954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.70825900775986, 439.12394772428996, 447.8074427995961, 448.54472710199155, 457.65675743192605, 19752.0, 20322.898385508088, 20513.17947282107, 20532.384028479133, 20553.177872885066, 18258.45224643263, 19772.60454790903, 20245.59508809823, 20737.170513179455, 20804.0, 5996.6402015879075, 6122.632642041492, 6141.078838174287, 6163.753449862, 6188.319284878659, 4406.162829062484, 5996.7301471433675, 6123.418275263843, 6470.870582588345, 6754.45964322853, 6696.3638454347, 6705.530612857102, 6727.899081513781, 6732.36042575957, 6734.090897728793, 6643.468522518187, 6686.7993960181275, 6720.6639668016405, 6728.52900296977, 6729.327067293256, 4119.443875076856, 5790.826275211751, 5935.228420305376, 6053.697315134225, 6062.030075187949, 23361.299161025196, 23407.88296058526, 23548.411289717722, 23845.403864903343, 23901.760982390126, 2546.2743118211406, 2803.0189433698247, 3159.336539326744, 3263.0210936719127, 3404.7957122572725, 10195.133413659847, 10598.947005264925, 10620.57517699291, 10729.034386905138, 14728.852711472855, 2014.788447213036, 2151.128792838903, 2163.0, 2193.6270833958106, 2296.70142881426, 85574.57212713959, 86876.56561717213, 88040.5597972006, 89637.55181224052, 89919.0, 11614.6515604532, 11659.0, 11735.530578776754, 11823.822642660367, 11922.616673314684, 16831.242594083295, 16975.236114374882, 16985.065821379696, 16995.23521441538, 17013.23440445183, 8351.33189344863, 8443.408961372645, 8609.311255099703, 8629.223369896614, 8719.12808719123, 8141.307988820898, 8148.714794982147, 8178.550179740171, 8272.545010024507, 8280.627371768285, 4912.901741965141, 4958.157113290749, 4997.7251251180805, 5040.218766091261, 5127.41034781005, 1880.2009146112848, 1926.807319268062, 2079.6256673798557, 2121.7772133925714, 2122.5542636046293, 976.7948730766618, 1048.09863517375, 1063.984040239397, 1077.7413420779114, 1100.1748688483638, 19644.50888727793, 19890.403287901387, 20299.59400812005, 20430.869218461376, 20652.483687907923, 1078.3857850945276, 1108.2353176308322, 1110.5058249079082, 1179.235887016461, 1180.2741314091943, 11369.545218191344, 11429.371384573762, 11513.136514761427, 11519.25124866881, 11549.942250288696, 559744.0, 563022.0, 567259.0, 574634.0, 580082.0, 102382.0, 103323.45014824784, 104921.0, 106089.46955265175, 106401.0, 1083.3770581915273, 1117.5250518529592, 1128.4301427779083, 1139.9658010259704, 1145.66202970124, 17746.733798992766, 18006.099695014935, 18086.5478363042, 18171.454856354332, 18240.908795455936, 40434.39348409835, 42304.15391692088, 42769.57230427656, 42775.71672849819, 44255.33616995812, 59449.702751485966, 60238.0, 61180.0, 61677.69161154165, 61887.690561548705, 8947.776305592412, 8999.55002249898, 9226.538673066454, 9242.584083716114, 9311.534423278945, 12210.877891220975, 13938.58184254474, 14084.507042253472, 14255.073420227653, 14490.565283041526, 9905.959874213391, 11425.0, 12096.879031209928, 12161.574344897886, 12190.390480475764, 12122.636320910387, 12209.267443953391, 12333.506659733868, 12616.810747838974, 12651.620451386472, 12625.242485450903, 12872.549460768829, 12973.935130324287, 13010.414531346301, 13173.40719667598, 8960.417572857743, 8999.64001439935, 9274.0, 9283.210927071275, 9374.67188648394, 8978.685745998859, 11718.414079296172, 12293.815592766294, 12429.627111186679, 12502.124851260325], "value": 9933.920681148618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.0799210532887, 1545.806774153231, 1587.9761803572949, 1745.7643218165545, 1849.8335149836512, 8465.830683386328, 8797.912020879789, 8815.074417186182, 8824.338174636896, 8832.425892317004, 8531.78670533237, 8653.783655408617, 8713.30293576514, 8719.956400218005, 8731.257843083346, 2178.575177840322, 2449.2652204338715, 2454.7913427358653, 2488.042103790036, 2529.127451029401, 2501.3371456564023, 2518.659980902582, 2535.4422027153996, 2535.8985640574447, 2535.949281014379, 2467.3584867934287, 2475.665785119013, 2475.8638274894874, 2476.826622136451, 2478.7149477810103, 2134.5304033112766, 2381.749916258785, 2452.9264122076365, 2455.8894849731805, 2457.5453541094867, 2424.7817696407233, 2425.1027119965547, 2433.5254625348066, 2435.622478515833, 2454.6072628379375, 8623.913760862373, 8625.741227763177, 8705.303575713928, 8722.040575536686, 8731.690246463018, 5195.7402129893735, 5348.064088784447, 5354.5180933715765, 5360.59795515334, 5388.703621300827, 3430.2110514581536, 3458.56767904012, 3549.8225088745717, 3618.7105031597407, 3630.8547658093644, 1147.9368634725088, 1157.074340527583, 1170.836082948388, 1183.1776915044047, 1203.506562309449, 11883.881161188365, 12056.819147712791, 12141.817872731915, 12142.817857732141, 12145.0, 4683.976580117078, 4767.785449654774, 4843.104025755176, 4843.951560484421, 4872.6832755870755, 10269.332493387907, 10314.0, 10338.844917326247, 10353.896461035294, 10368.637097701545, 4959.380077490314, 5394.244805727201, 5415.323084614423, 5433.212184233264, 5447.645903016291, 4910.90178196434, 5016.021875734197, 5032.84901452957, 5035.043341765127, 5052.191649336089, 4126.195391898551, 4172.3532852407925, 4284.0, 4292.248856450109, 4426.712263702849, 1342.2818791946456, 1377.7864431013209, 1397.2175581674092, 1406.2757679794709, 1409.6969151632447, 984.0946329376991, 1075.306427354352, 1091.6943255888364, 1093.2565855218527, 1103.713034610991, 6142.508599312045, 6144.324124346318, 6329.430351268408, 6353.904691429632, 6374.681265936684, 1027.3219675014454, 1047.2512153810062, 1061.1192710050639, 1066.376169940578, 1069.8395240713799, 4268.253377959589, 4414.161309351213, 4438.844640437569, 4529.09418116378, 4583.679142459996, 10680.092192163753, 10973.286736362112, 11079.612213572647, 11178.720531986766, 11207.383593902414, 10727.463626818628, 10802.297850639683, 10992.725181870517, 11112.22214444981, 11118.22172447937, 8053.315468185153, 8215.630296636666, 8230.711925082593, 8354.498730076215, 8404.0, 5936.851578710394, 6130.2030736004035, 6154.446099850856, 6167.136600875791, 6313.273973492924, 9765.267604929517, 9776.26677999167, 9980.950095249767, 10025.0, 10182.490875456346, 9906.05892440217, 9984.650537231162, 10058.899411005796, 10064.69805905824, 10174.847377289494, 7292.088488938883, 7489.325960663567, 7714.3442807362, 7720.961395192988, 7895.328897043815, 8526.275266602408, 8539.274161696077, 8612.78468038279, 8614.526201058752, 8616.741497755078, 7621.466497345133, 7847.882281765892, 7883.5664038478435, 7888.132305446282, 7976.162502937108, 7705.884411733717, 7753.0, 7769.961150194213, 7832.216778322122, 7867.09528404218, 7099.893501597377, 7160.606166660884, 7269.127704675473, 7316.780496585111, 7316.817079573053, 5370.194470829407, 5514.255575497256, 5522.917156242579, 5551.861203469945, 5706.172604972338, 5302.973485132549, 5456.154296084113, 5584.944150558443, 5727.713614319184, 5758.3090029196765], "value": 4799.520773336936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.4198808983043, 350.3326163658232, 350.79829098268505, 367.86389036056653, 371.94048952167657, 5343.5114503816785, 5386.569074474042, 5442.2380866678695, 5445.319335083114, 5478.123500239957, 5445.918311225335, 5486.753096110675, 5487.7530511127, 5542.584306177043, 5557.638753481031, 4100.774457404841, 4228.175505776375, 4342.565743425664, 4369.759663218521, 4413.668974826885, 4316.726565663122, 4347.760873151976, 4371.562843715635, 4377.102693947733, 4378.211921854065, 4314.460692413449, 4317.244482215599, 4325.762083085445, 4357.215701173787, 4367.759773212472, 4096.283150448659, 4310.741355518679, 4319.114581510783, 4389.868303950887, 4408.58118478744, 3792.7345085844004, 3799.5371781863905, 3817.9427308590393, 3818.522684664417, 3823.833730712132, 5136.460671629462, 5305.204219367087, 5327.760250788724, 5331.2269720890645, 5351.491608297206, 4919.188333924898, 4924.950750492485, 4945.0, 4945.357103576512, 4954.60363170949, 5756.7985120521, 5768.413686236277, 5773.191753154561, 5792.160136780185, 5828.446297601721, 4102.979485102555, 4187.434696315989, 4229.0, 4235.2800023996, 4249.766262855542, 5821.563382746311, 5910.497607703351, 5915.467607915265, 5932.555058370596, 5948.780499997491, 4243.596858298457, 4297.785110744513, 4299.398084268205, 4310.676699247506, 4316.719413238192, 4240.363945408213, 4306.720063195882, 4350.173467041315, 4356.0, 4365.432493775852, 4674.205385084544, 4924.507549245119, 4937.851864444073, 4947.925781113287, 4948.554630083309, 5610.495055444948, 5633.915491267634, 5636.408177141341, 5665.66006039639, 5674.687892165888, 1554.1995872125865, 1575.7006168827886, 1577.5346272849538, 1582.7388480900752, 1591.90448573086, 1051.821190397619, 1058.2486434631344, 1067.743741502034, 1080.7460246841986, 1081.5511562701547, 5972.522198224132, 5987.760489580455, 6008.128821320884, 6026.734385779036, 6033.245844269466, 6307.148534947723, 6333.651649159248, 6338.461230795434, 6350.523710721714, 6367.299597044322, 5822.970885145632, 5898.318979091025, 5925.822225333247, 5953.315368732565, 5980.970095149496, 3352.245744707421, 3356.664333566624, 3363.64681708422, 3384.4077286474767, 3387.81367024816, 5900.498457631149, 6188.81433556994, 6199.0, 6506.577072490273, 6544.181977252843, 5971.373005834412, 6027.523256802024, 6039.275286965504, 6042.818715438544, 6069.575129740876, 5945.346011938596, 6224.253089629183, 6231.105559025609, 6231.376862313732, 6267.370483674277, 5966.940330596639, 5976.551758618208, 5988.28140623128, 6002.349353927705, 6049.304330002106, 5930.8220753375745, 5930.851728706644, 5956.166136740946, 5968.552358573038, 5973.611715238496, 5877.500412464818, 6197.442230199304, 6221.0, 6228.439440450381, 6238.625682459067, 4290.056187638715, 4344.717593356421, 4370.868873933787, 4372.982641977026, 4382.189294980439, 5603.243562119062, 5719.542436604978, 5986.682929755447, 6070.878582428415, 6081.756729730761, 5812.0, 5813.883722325614, 5851.327097383855, 5862.413758624274, 5863.501602363676, 5787.131930210334, 5794.275715535558, 5820.505257053029, 5821.650700957956, 5863.237779088691, 5435.592330575302, 5641.182028605911, 5680.943190568041, 5721.885562288814, 5754.395788442153, 5794.971025144847, 5814.418558144152, 5860.443257890493, 5862.501687356452, 5908.675022873611, 5549.916751248654, 5721.628094173865, 5725.398833122462, 5745.6552606843725, 5749.223854779719], "value": 4486.2699805471175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.9699010534632, 897.48394673063, 909.2680392284211, 925.8379783537879, 936.0499093420179, 15891.125988070666, 16045.358185672574, 16100.194990250498, 17454.91272543639, 18092.185851636674, 16658.916705416486, 16688.33246670132, 16777.161141942914, 16834.158292085376, 16863.07253101082, 737.9372753315974, 887.1926546842375, 901.8286525560155, 913.8355096082703, 914.5655813488606, 908.3459908865606, 909.9454032758023, 911.6854685133618, 913.0458670689112, 913.4701872913728, 956.4261443134098, 963.7012526116927, 965.0783501755807, 965.1024547171128, 965.5461932891565, 768.2816566510303, 909.3498148823622, 934.6308208257768, 957.1624828275259, 958.0467434902282, 680.8263892707328, 683.2211279141783, 684.3191024930177, 684.4114061906756, 684.8972654101875, 15701.057936523845, 15709.685806283924, 15730.842691573167, 15736.055836649723, 15785.842141578552, 14306.28468576567, 14634.682878540982, 14687.77968330476, 14688.0, 14815.925920370437, 12236.327002014885, 12360.752784944341, 12412.75174496514, 12415.93792031034, 12663.430145643468, 4039.596040395966, 4041.9191616167805, 4058.5738497457933, 4130.339145736668, 4173.624373806372, 58562.41437585612, 58589.99999999957, 58801.7059914702, 58863.70568147132, 59005.704971474865, 11438.142139339416, 11525.0, 11714.824277635842, 11797.056235501312, 11831.349275789915, 21146.577068458544, 21480.570388592452, 21486.677699834516, 21496.89251553732, 21543.13827446916, 8981.371304008788, 9096.226820720312, 9178.93106119291, 9188.954055229815, 9311.255099592152, 5279.709615971158, 5341.62608617393, 5364.356277246756, 5406.54044406222, 5410.08028635133, 3666.7983260920373, 3771.981140094282, 3791.431285307226, 3801.163743976321, 3803.353429916921, 710.261698791662, 711.8896571031395, 712.4407340237889, 719.5898337947424, 721.5526373648266, 667.4726965697045, 760.5702777930452, 761.4251240313528, 774.2953911940108, 809.0978558906894, 10364.5335959882, 10368.22238332113, 10371.844422333672, 10432.895671043345, 10543.156547476183, 837.8282452097305, 838.4759525296689, 840.5293035899793, 857.5412154497438, 866.5234121233296, 4625.699329543569, 4641.164590373698, 4659.301104834234, 4671.649626278043, 4701.929471057937, 61990.69004654948, 62604.373956260766, 65241.673791631685, 66715.66642166855, 67029.32970670328, 55010.44989550133, 56153.71923140358, 57320.14019789623, 59058.40941590615, 59901.0, 48063.279050814264, 50181.0, 53895.19157212645, 54061.459385405644, 56524.71737641285, 9615.56729947168, 9729.444344828813, 9923.156531694887, 9993.250506211918, 10300.948495257475, 32368.0, 35924.4611330825, 36321.27357452889, 36345.27309453849, 37202.0, 46402.30396543987, 47493.287600685326, 47929.52070479251, 49142.75428622834, 49280.75359623179, 13280.0, 13321.53374631922, 13525.120867143603, 13629.86370136286, 13791.10357826738, 14075.507357242448, 15060.623484412978, 15215.0, 15539.13530376362, 15704.685906282039, 12925.0, 13414.216428468646, 13514.391852366864, 14307.92846035763, 14568.781468278195, 13476.326183690971, 13903.721925561229, 14155.716885662023, 14159.150450972975, 14190.574282771533, 13852.052165132889, 14094.929525352718, 14230.857691422952, 14335.426582936983, 14427.49503767363, 11766.235194712317, 11833.644990650295, 11951.402429878644, 12161.39193040362, 12181.08641851847, 11184.384858832842, 11291.322520648788, 11627.883721163018, 11648.0, 11655.59205427806], "value": 7420.685997572064, "unit": "score"}], "name": "dromaeo_css", "value": 7490.457297699827, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 105.0, 108.0, 110.0, 111.0, 99.0, 110.0, 109.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 158.0, 171.0, 135.0, 171.0, 151.0, 132.0, 182.0, 126.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 170.0, 161.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 175.0, 77.0, 75.0, 76.0, 76.0, 166.0, 77.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 159.0, 92.0, 92.0, 92.0, 154.0, 92.0, 92.0, 151.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 56.0, 56.0, 57.0, 55.0, 73.0, 55.0, 60.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 81.0, 76.0, 75.0, 72.0, 73.0, 72.0, 72.0, 72.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 126.0, 117.0, 120.0, 119.0, 116.0, 116.0, 119.0, 157.0, 123.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 158.0, 162.0, 160.0, 162.0, 156.0, 164.0, 165.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1522.5, "alertThreshold": 2.0}]} 09:58:55 INFO - Return code: 0 09:58:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:58:55 ERROR - # TBPL SUCCESS # 09:58:55 INFO - Running post-action listener: _resource_record_post_action 09:58:55 INFO - Running post-run listener: _resource_record_post_run 09:58:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319762432; Read time: 16; Write time: 437508 09:58:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77991936; Read time: 0; Write time: 149924 09:58:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 241770496; Read time: 16; Write time: 287584 09:58:56 INFO - Running post-run listener: _upload_blobber_files 09:58:56 INFO - Blob upload gear active. 09:58:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:56 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 09:58:56 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:58:56 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:58:57 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:58:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:58 INFO - (blobuploader) - INFO - Done attempting. 09:58:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:58:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:58:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:58 INFO - (blobuploader) - INFO - Done attempting. 09:58:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:58 INFO - Return code: 0 09:58:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7072872cd71d0374bee2939eba335e2c5d7774306f471e3334140f13f5619fc5f844c49188c963cee0019bb1467f0f003364b40d0dc7ea1a02635d8e67451c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b53d55b6d79b8cb244d85f008c53f1a983fa04c4c971403649a26f8085f37d43ed030bb05875f7f6e09e02fd59c3f8d0ef016bcca96fb6d249f4bea8d0bf6d9"} 09:58:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:59 INFO - Contents: 09:58:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7072872cd71d0374bee2939eba335e2c5d7774306f471e3334140f13f5619fc5f844c49188c963cee0019bb1467f0f003364b40d0dc7ea1a02635d8e67451c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b53d55b6d79b8cb244d85f008c53f1a983fa04c4c971403649a26f8085f37d43ed030bb05875f7f6e09e02fd59c3f8d0ef016bcca96fb6d249f4bea8d0bf6d9"} 09:58:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:59 INFO - Copying logs to upload dir... 09:58:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2129.534222 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 29 secs) (at 2016-05-04 09:58:58.895669) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 09:58:58.898886) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 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-Aurora/sha512/a7072872cd71d0374bee2939eba335e2c5d7774306f471e3334140f13f5619fc5f844c49188c963cee0019bb1467f0f003364b40d0dc7ea1a02635d8e67451c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b53d55b6d79b8cb244d85f008c53f1a983fa04c4c971403649a26f8085f37d43ed030bb05875f7f6e09e02fd59c3f8d0ef016bcca96fb6d249f4bea8d0bf6d9"} build_url:https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/b0dDXjgbTiK_Qm6k52H0Kg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a7072872cd71d0374bee2939eba335e2c5d7774306f471e3334140f13f5619fc5f844c49188c963cee0019bb1467f0f003364b40d0dc7ea1a02635d8e67451c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b53d55b6d79b8cb244d85f008c53f1a983fa04c4c971403649a26f8085f37d43ed030bb05875f7f6e09e02fd59c3f8d0ef016bcca96fb6d249f4bea8d0bf6d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-04 09:58:58.923272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:58:58.923585) ========= 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=14ef55db36f7623abb31b9cf000001d5-1462378369.949632-1950322467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-04 09:58:59.007350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 09:58:59.007670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-04 09:58:59.007947) ========= ========= Total master_lag: 0.21 =========