builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1462281869.08 results: success (0) buildid: 20160503034638 builduid: 19fd5e7a3c624b14b5efdef960bfdfb0 revision: d4e57dcb78d71fffd6b33088a11e051a294e5c14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.080523) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.081107) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.081424) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.098335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.099006) ========= 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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-03 06:24:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-05-03 06:24:29 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.231827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.232198) ========= 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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.282062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:29.282453) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d4e57dcb78d71fffd6b33088a11e051a294e5c14 --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 d4e57dcb78d71fffd6b33088a11e051a294e5c14 --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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-03 06:24:29,416 truncating revision to first 12 chars 2016-05-03 06:24:29,416 Setting DEBUG logging. 2016-05-03 06:24:29,416 attempt 1/10 2016-05-03 06:24:29,416 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d4e57dcb78d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-03 06:24:29,854 unpacking tar archive at: mozilla-aurora-d4e57dcb78d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:30.019906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:30.020303) ========= script_repo_revision: d4e57dcb78d71fffd6b33088a11e051a294e5c14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:30.020747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:30.021062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 06:24:30.030520) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 25 secs) (at 2016-05-03 06:24:30.030945) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:24:30 INFO - MultiFileLogger online at 20160503 06:24:30 in /builds/slave/test 06:24:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:24:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:24:30 INFO - {'append_to_log': False, 06:24:30 INFO - 'base_work_dir': '/builds/slave/test', 06:24:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:24:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:24:30 INFO - 'branch': 'Mozilla-Aurora', 06:24:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:24:30 INFO - 'config_files': ('talos/linux_config.py',), 06:24:30 INFO - 'default_actions': ('clobber', 06:24:30 INFO - 'read-buildbot-config', 06:24:30 INFO - 'download-and-extract', 06:24:30 INFO - 'populate-webroot', 06:24:30 INFO - 'create-virtualenv', 06:24:30 INFO - 'install', 06:24:30 INFO - 'run-tests'), 06:24:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:24:30 INFO - 'download_minidump_stackwalk': True, 06:24:30 INFO - 'download_symbols': 'ondemand', 06:24:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:24:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:24:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:24:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:24:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:24:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:24:30 INFO - 'installer_path': 'installer.exe', 06:24:30 INFO - 'log_level': 'info', 06:24:30 INFO - 'log_name': 'talos', 06:24:30 INFO - 'log_to_console': True, 06:24:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:24:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:24:30 INFO - 'opt_config_files': (), 06:24:30 INFO - 'pip_index': False, 06:24:30 INFO - 'sps_profile': False, 06:24:30 INFO - 'sps_profile_interval': 0, 06:24:30 INFO - 'suite': 'dromaeojs-e10s', 06:24:30 INFO - 'system_bits': '32', 06:24:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:24:30 INFO - 'title': 'talos-linux64-ix-031', 06:24:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:24:30 INFO - 'use_talos_json': True, 06:24:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:24:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:24:30 INFO - 'work_dir': 'build'} 06:24:30 INFO - ##### 06:24:30 INFO - ##### Running clobber step. 06:24:30 INFO - ##### 06:24:30 INFO - Running pre-action listener: _resource_record_pre_action 06:24:30 INFO - Running main action method: clobber 06:24:30 INFO - rmtree: /builds/slave/test/build 06:24:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:24:31 INFO - Running post-action listener: _resource_record_post_action 06:24:31 INFO - ##### 06:24:31 INFO - ##### Running read-buildbot-config step. 06:24:31 INFO - ##### 06:24:31 INFO - Running pre-action listener: _resource_record_pre_action 06:24:31 INFO - Running main action method: read_buildbot_config 06:24:31 INFO - Using buildbot properties: 06:24:31 INFO - { 06:24:31 INFO - "project": "", 06:24:31 INFO - "product": "firefox", 06:24:31 INFO - "script_repo_revision": "production", 06:24:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:24:31 INFO - "repository": "", 06:24:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:24:31 INFO - "buildid": "20160503034638", 06:24:31 INFO - "pgo_build": "True", 06:24:31 INFO - "basedir": "/builds/slave/test", 06:24:31 INFO - "buildnumber": 279, 06:24:31 INFO - "slavename": "talos-linux64-ix-031", 06:24:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:24:31 INFO - "platform": "ubuntu64_hw", 06:24:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:24:31 INFO - "branch": "mozilla-aurora", 06:24:31 INFO - "repo_path": "releases/mozilla-aurora", 06:24:31 INFO - "revision": "d4e57dcb78d71fffd6b33088a11e051a294e5c14", 06:24:31 INFO - "stage_platform": "linux64-pgo", 06:24:31 INFO - "builduid": "19fd5e7a3c624b14b5efdef960bfdfb0", 06:24:31 INFO - "slavebuilddir": "test" 06:24:31 INFO - } 06:24:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:24:31 INFO - Running post-action listener: _resource_record_post_action 06:24:31 INFO - ##### 06:24:31 INFO - ##### Running download-and-extract step. 06:24:31 INFO - ##### 06:24:31 INFO - Running pre-action listener: _resource_record_pre_action 06:24:31 INFO - Running main action method: download_and_extract 06:24:31 INFO - mkdir: /builds/slave/test/build/tests 06:24: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')]} 06:24:31 INFO - https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:25:01 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 06:25:01 INFO - retry: attempt #1 caught exception: timed out 06:25:01 INFO - retry: Failed, sleeping 30 seconds before retrying 06:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:26:01 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 06:26:01 INFO - retry: attempt #2 caught exception: timed out 06:26:01 INFO - retry: Failed, sleeping 60 seconds before retrying 06:27:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:27:31 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json: timed out 06:27:31 INFO - retry: attempt #3 caught exception: timed out 06:27:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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! 06:27:31 INFO - Caught exception: timed out 06:27:31 INFO - Caught exception: timed out 06:27:31 INFO - Caught exception: timed out 06:27:31 INFO - trying https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:27:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:27:32 INFO - Downloaded 1361 bytes. 06:27:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:27:32 INFO - Using the following test package requirements: 06:27:32 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:27:32 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:27:32 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:27:32 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'jsshell-linux-x86_64.zip'], 06:27:32 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:27:32 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:27:32 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:27:32 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:27:32 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:27:32 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:27:32 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:27:32 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:32 INFO - https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:27:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:27:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:28:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:28:02 INFO - retry: attempt #1 caught exception: timed out 06:28:02 INFO - retry: Failed, sleeping 30 seconds before retrying 06:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:29:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:29:02 INFO - retry: attempt #2 caught exception: timed out 06:29:02 INFO - retry: Failed, sleeping 60 seconds before retrying 06:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:30:32 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:30:32 INFO - retry: attempt #3 caught exception: timed out 06:30:32 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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! 06:30:32 INFO - Caught exception: timed out 06:30:32 INFO - Caught exception: timed out 06:30:32 INFO - Caught exception: timed out 06:30:32 INFO - trying https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:30:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:30:33 INFO - Downloaded 23823093 bytes. 06:30:33 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'] 06:30:33 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 06:30:34 INFO - Return code: 0 06:30: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 06:30: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')]} 06:30:34 INFO - https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:31:04 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:31:04 INFO - retry: attempt #1 caught exception: timed out 06:31:04 INFO - retry: Failed, sleeping 30 seconds before retrying 06:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:32:04 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:32:04 INFO - retry: attempt #2 caught exception: timed out 06:32:04 INFO - retry: Failed, sleeping 60 seconds before retrying 06:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:33:34 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip: timed out 06:33:34 INFO - retry: attempt #3 caught exception: timed out 06:33:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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! 06:33:34 INFO - Caught exception: timed out 06:33:34 INFO - Caught exception: timed out 06:33:34 INFO - Caught exception: timed out 06:33:34 INFO - trying https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:33:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:33:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:33:35 INFO - Downloaded 23823093 bytes. 06:33: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'] 06:33: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 06:33:37 INFO - Return code: 0 06:33:37 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')]} 06:33:37 INFO - https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:34:07 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 06:34:07 INFO - retry: attempt #1 caught exception: timed out 06:34:07 INFO - retry: Failed, sleeping 30 seconds before retrying 06:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:35:07 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 06:35:07 INFO - retry: attempt #2 caught exception: timed out 06:35:07 INFO - retry: Failed, sleeping 60 seconds before retrying 06:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:36:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip: timed out 06:36:37 INFO - retry: attempt #3 caught exception: timed out 06:36:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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! 06:36:37 INFO - Caught exception: timed out 06:36:37 INFO - Caught exception: timed out 06:36:37 INFO - Caught exception: timed out 06:36:37 INFO - trying https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:36:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:36:38 INFO - Downloaded 10840145 bytes. 06:36: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'] 06:36: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 06:36:38 INFO - Return code: 0 06:36: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')]} 06:36:38 INFO - https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:36:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:36:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:36:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:37:08 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 06:37:08 INFO - retry: attempt #1 caught exception: timed out 06:37:08 INFO - retry: Failed, sleeping 30 seconds before retrying 06:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:38:09 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 06:38:09 INFO - retry: attempt #2 caught exception: timed out 06:38:09 INFO - retry: Failed, sleeping 60 seconds before retrying 06:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:39:39 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2: timed out 06:39:39 INFO - retry: attempt #3 caught exception: timed out 06:39:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZRg1FZJLTOeR4APj1S1USw/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! 06:39:39 INFO - Caught exception: timed out 06:39:39 INFO - Caught exception: timed out 06:39:39 INFO - Caught exception: timed out 06:39:39 INFO - trying https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:39:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:39:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/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 06:39:40 INFO - Downloaded 62698939 bytes. 06:39:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:39:40 INFO - mkdir: /builds/slave/test/properties 06:39:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:40 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:40 INFO - Contents: 06:39:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:39:41 INFO - Running post-action listener: _resource_record_post_action 06:39:41 INFO - Running post-action listener: set_extra_try_arguments 06:39:41 INFO - ##### 06:39:41 INFO - ##### Running populate-webroot step. 06:39:41 INFO - ##### 06:39:41 INFO - Running pre-action listener: _resource_record_pre_action 06:39:41 INFO - Running main action method: populate_webroot 06:39:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:41 INFO - '--tppagecycles', 06:39:41 INFO - '7'], 06:39:41 INFO - 'tests': ['tsvgm']}}, 06:39:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['damp', 'tps']}, 06:39:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'tests': ['damp', 'tps']}, 06:39:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['dromaeo_dom']}, 06:39:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['a11yr', 06:39:41 INFO - 'ts_paint', 06:39:41 INFO - 'tpaint', 06:39:41 INFO - 'sessionrestore', 06:39:41 INFO - 'sessionrestore_no_auto_restore', 06:39:41 INFO - 'tabpaint']}, 06:39:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['tsvgx', 06:39:41 INFO - 'tsvgr_opacity', 06:39:41 INFO - 'tart', 06:39:41 INFO - 'tscrollx', 06:39:41 INFO - 'cart']}, 06:39:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:41 INFO - 'tsvgr_opacity', 06:39:41 INFO - 'tart', 06:39:41 INFO - 'tscrollx', 06:39:41 INFO - 'cart']}, 06:39:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'talos_options': ['--disable-e10s'], 06:39:41 INFO - 'tests': ['tp5o']}, 06:39:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'tests': ['tp5o']}, 06:39:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'talos_options': ['--disable-e10s', 06:39:41 INFO - '--xperf_path', 06:39:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:41 INFO - 'tests': ['tp5n']}, 06:39:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:41 INFO - 'talos_options': ['--xperf_path', 06:39:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:41 INFO - 'tests': ['tp5n']}}, 06:39:41 INFO - 'talos.zip': {'path': '', 06:39:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:41 INFO - Running post-action listener: _resource_record_post_action 06:39:41 INFO - ##### 06:39:41 INFO - ##### Running create-virtualenv step. 06:39:41 INFO - ##### 06:39:41 INFO - Running pre-action listener: _resource_record_pre_action 06:39:41 INFO - Running main action method: create_virtualenv 06:39:41 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:41 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 06:39:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:41 INFO - Using real prefix '/usr' 06:39:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:41 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:43 INFO - Installing pip.................done. 06:39:43 INFO - Return code: 0 06:39:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39: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 06:39: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 06:39:43 INFO - Using env: {'DISPLAY': ':0', 06:39:43 INFO - 'HOME': '/home/cltbld', 06:39:43 INFO - 'LANG': 'en_US.UTF-8', 06:39:43 INFO - 'LANGUAGE': 'en_US:en', 06:39:43 INFO - 'LOGNAME': 'cltbld', 06:39:43 INFO - 'MAIL': '/var/mail/cltbld', 06:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:43 INFO - 'MOZ_NO_REMOTE': '1', 06:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:43 INFO - 'NO_EM_RESTART': '1', 06:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:43 INFO - 'PWD': '/builds/slave/test', 06:39:43 INFO - 'SHELL': '/bin/bash', 06:39:43 INFO - 'SHLVL': '1', 06:39:43 INFO - 'TERM': 'linux', 06:39:43 INFO - 'TMOUT': '86400', 06:39:43 INFO - 'USER': 'cltbld', 06:39:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:43 INFO - '_': '/tools/buildbot/bin/python'} 06:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:44 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 06:39:44 INFO - Cleaning up... 06:39:44 INFO - Return code: 0 06:39:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:44 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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39:44 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 06:39:44 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 06:39:44 INFO - Using env: {'DISPLAY': ':0', 06:39:44 INFO - 'HOME': '/home/cltbld', 06:39:44 INFO - 'LANG': 'en_US.UTF-8', 06:39:44 INFO - 'LANGUAGE': 'en_US:en', 06:39:44 INFO - 'LOGNAME': 'cltbld', 06:39:44 INFO - 'MAIL': '/var/mail/cltbld', 06:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:44 INFO - 'MOZ_NO_REMOTE': '1', 06:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:44 INFO - 'NO_EM_RESTART': '1', 06:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:44 INFO - 'PWD': '/builds/slave/test', 06:39:44 INFO - 'SHELL': '/bin/bash', 06:39:44 INFO - 'SHLVL': '1', 06:39:44 INFO - 'TERM': 'linux', 06:39:44 INFO - 'TMOUT': '86400', 06:39:44 INFO - 'USER': 'cltbld', 06:39:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:44 INFO - '_': '/tools/buildbot/bin/python'} 06:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:44 INFO - Downloading/unpacking psutil>=0.7.1 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:46 INFO - Installing collected packages: psutil 06:39:46 INFO - Running setup.py install for psutil 06:39:46 INFO - building 'psutil._psutil_linux' extension 06:39:46 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 06:39:46 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 06:39:46 INFO - building 'psutil._psutil_posix' extension 06:39:46 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 06:39:46 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 06:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:46 INFO - Successfully installed psutil 06:39:46 INFO - Cleaning up... 06:39:46 INFO - Return code: 0 06:39:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39: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 06:39: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 06:39:46 INFO - Using env: {'DISPLAY': ':0', 06:39:46 INFO - 'HOME': '/home/cltbld', 06:39:46 INFO - 'LANG': 'en_US.UTF-8', 06:39:46 INFO - 'LANGUAGE': 'en_US:en', 06:39:46 INFO - 'LOGNAME': 'cltbld', 06:39:46 INFO - 'MAIL': '/var/mail/cltbld', 06:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:46 INFO - 'MOZ_NO_REMOTE': '1', 06:39:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:46 INFO - 'NO_EM_RESTART': '1', 06:39:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:46 INFO - 'PWD': '/builds/slave/test', 06:39:46 INFO - 'SHELL': '/bin/bash', 06:39:46 INFO - 'SHLVL': '1', 06:39:46 INFO - 'TERM': 'linux', 06:39:46 INFO - 'TMOUT': '86400', 06:39:46 INFO - 'USER': 'cltbld', 06:39:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:46 INFO - '_': '/tools/buildbot/bin/python'} 06:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39: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) 06:39:48 INFO - Installing collected packages: mozsystemmonitor 06:39:48 INFO - Running setup.py install for mozsystemmonitor 06:39:49 INFO - Successfully installed mozsystemmonitor 06:39:49 INFO - Cleaning up... 06:39:49 INFO - Return code: 0 06:39:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:49 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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39:49 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 06:39:49 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 06:39:49 INFO - Using env: {'DISPLAY': ':0', 06:39:49 INFO - 'HOME': '/home/cltbld', 06:39:49 INFO - 'LANG': 'en_US.UTF-8', 06:39:49 INFO - 'LANGUAGE': 'en_US:en', 06:39:49 INFO - 'LOGNAME': 'cltbld', 06:39:49 INFO - 'MAIL': '/var/mail/cltbld', 06:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:49 INFO - 'MOZ_NO_REMOTE': '1', 06:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:49 INFO - 'NO_EM_RESTART': '1', 06:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:49 INFO - 'PWD': '/builds/slave/test', 06:39:49 INFO - 'SHELL': '/bin/bash', 06:39:49 INFO - 'SHLVL': '1', 06:39:49 INFO - 'TERM': 'linux', 06:39:49 INFO - 'TMOUT': '86400', 06:39:49 INFO - 'USER': 'cltbld', 06:39:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:49 INFO - '_': '/tools/buildbot/bin/python'} 06:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:49 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:51 INFO - Downloading docopt-0.6.1.tar.gz 06:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:51 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:51 INFO - Running setup.py install for blobuploader 06:39:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:52 INFO - Running setup.py install for requests 06:39:52 INFO - Running setup.py install for docopt 06:39:52 INFO - Successfully installed blobuploader requests docopt 06:39:52 INFO - Cleaning up... 06:39:52 INFO - Return code: 0 06:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:52 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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39:52 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 06:39:52 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 06:39:52 INFO - Using env: {'DISPLAY': ':0', 06:39:52 INFO - 'HOME': '/home/cltbld', 06:39:52 INFO - 'LANG': 'en_US.UTF-8', 06:39:52 INFO - 'LANGUAGE': 'en_US:en', 06:39:52 INFO - 'LOGNAME': 'cltbld', 06:39:52 INFO - 'MAIL': '/var/mail/cltbld', 06:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:52 INFO - 'MOZ_NO_REMOTE': '1', 06:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:52 INFO - 'NO_EM_RESTART': '1', 06:39:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:52 INFO - 'PWD': '/builds/slave/test', 06:39:52 INFO - 'SHELL': '/bin/bash', 06:39:52 INFO - 'SHLVL': '1', 06:39:52 INFO - 'TERM': 'linux', 06:39:52 INFO - 'TMOUT': '86400', 06:39:52 INFO - 'USER': 'cltbld', 06:39:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:52 INFO - '_': '/tools/buildbot/bin/python'} 06:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:52 INFO - Running setup.py (path:/tmp/pip-Abjbpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:52 INFO - Running setup.py (path:/tmp/pip-P9_CM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:52 INFO - Running setup.py (path:/tmp/pip-gki1Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:52 INFO - Running setup.py (path:/tmp/pip-1gEquB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:53 INFO - Running setup.py (path:/tmp/pip-_BbStk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:53 INFO - Running setup.py (path:/tmp/pip-v8fTFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:53 INFO - Running setup.py (path:/tmp/pip-cTE3X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:53 INFO - Running setup.py (path:/tmp/pip-RhwF1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:53 INFO - Running setup.py (path:/tmp/pip-LiMHLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:53 INFO - Running setup.py (path:/tmp/pip-N76WVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:53 INFO - Running setup.py (path:/tmp/pip-kmmTh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:53 INFO - Running setup.py (path:/tmp/pip-xS_aCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:53 INFO - Running setup.py (path:/tmp/pip-j5KlT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:53 INFO - Running setup.py (path:/tmp/pip-2oEkly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:53 INFO - Running setup.py (path:/tmp/pip-RFOBLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:53 INFO - Running setup.py (path:/tmp/pip-k7pqbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:53 INFO - Running setup.py (path:/tmp/pip-RsMt6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:53 INFO - Running setup.py install for manifestparser 06:39:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for mozcrash 06:39:54 INFO - Running setup.py install for mozdebug 06:39:54 INFO - Running setup.py install for mozdevice 06:39:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for mozfile 06:39:54 INFO - Running setup.py install for mozhttpd 06:39:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for mozinfo 06:39:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for mozInstall 06:39:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for mozleak 06:39:54 INFO - Running setup.py install for mozlog 06:39:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:54 INFO - Running setup.py install for moznetwork 06:39:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Running setup.py install for mozprocess 06:39:55 INFO - Running setup.py install for mozprofile 06:39:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Running setup.py install for mozrunner 06:39:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Running setup.py install for mozscreenshot 06:39:55 INFO - Running setup.py install for moztest 06:39:55 INFO - Running setup.py install for mozversion 06:39:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:55 INFO - Cleaning up... 06:39:55 INFO - Return code: 0 06:39:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39: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 06:39: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 06:39:55 INFO - Using env: {'DISPLAY': ':0', 06:39:55 INFO - 'HOME': '/home/cltbld', 06:39:55 INFO - 'LANG': 'en_US.UTF-8', 06:39:55 INFO - 'LANGUAGE': 'en_US:en', 06:39:55 INFO - 'LOGNAME': 'cltbld', 06:39:55 INFO - 'MAIL': '/var/mail/cltbld', 06:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:55 INFO - 'MOZ_NO_REMOTE': '1', 06:39:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:55 INFO - 'NO_EM_RESTART': '1', 06:39:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:55 INFO - 'PWD': '/builds/slave/test', 06:39:55 INFO - 'SHELL': '/bin/bash', 06:39:55 INFO - 'SHLVL': '1', 06:39:55 INFO - 'TERM': 'linux', 06:39:55 INFO - 'TMOUT': '86400', 06:39:55 INFO - 'USER': 'cltbld', 06:39:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:55 INFO - '_': '/tools/buildbot/bin/python'} 06:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:55 INFO - Running setup.py (path:/tmp/pip-YizzpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:56 INFO - Running setup.py (path:/tmp/pip-6icZw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:56 INFO - Running setup.py (path:/tmp/pip-mYAgKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:56 INFO - Running setup.py (path:/tmp/pip-eZzTVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:56 INFO - Running setup.py (path:/tmp/pip-4nqumI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:56 INFO - Running setup.py (path:/tmp/pip-dAE8ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:56 INFO - Running setup.py (path:/tmp/pip-aTwh6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:56 INFO - Running setup.py (path:/tmp/pip-PeUv__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:56 INFO - Running setup.py (path:/tmp/pip-zVPmGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:56 INFO - Running setup.py (path:/tmp/pip-kQZA86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:56 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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:56 INFO - Running setup.py (path:/tmp/pip-WWQpPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39: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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:56 INFO - Running setup.py (path:/tmp/pip-jVKLJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39: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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:56 INFO - Running setup.py (path:/tmp/pip-tr5x7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39: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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:56 INFO - Running setup.py (path:/tmp/pip-BwsrdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39: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)) 06:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:56 INFO - Running setup.py (path:/tmp/pip-1hlACT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:57 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)) 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:57 INFO - Running setup.py (path:/tmp/pip-XqzuiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:57 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)) 06:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:57 INFO - Running setup.py (path:/tmp/pip-FZtzhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:57 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)) 06:39:57 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)) 06:39:57 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)) 06:39:57 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)) 06:39:57 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)) 06:39:57 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)) 06:39:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:59 INFO - Downloading blessings-1.6.tar.gz 06:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:59 INFO - Installing collected packages: blessings 06:39:59 INFO - Running setup.py install for blessings 06:39:59 INFO - Successfully installed blessings 06:39:59 INFO - Cleaning up... 06:39:59 INFO - Return code: 0 06:39:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:59 INFO - Reading from file tmpfile_stdout 06:39:59 INFO - Current package versions: 06:39:59 INFO - argparse == 1.2.1 06:39:59 INFO - blessings == 1.6 06:39:59 INFO - blobuploader == 1.2.4 06:39:59 INFO - docopt == 0.6.1 06:39:59 INFO - manifestparser == 1.1 06:39:59 INFO - mozInstall == 1.12 06:39:59 INFO - mozcrash == 0.17 06:39:59 INFO - mozdebug == 0.1 06:39:59 INFO - mozdevice == 0.48 06:39:59 INFO - mozfile == 1.2 06:39:59 INFO - mozhttpd == 0.7 06:39:59 INFO - mozinfo == 0.9 06:39:59 INFO - mozleak == 0.1 06:39:59 INFO - mozlog == 3.1 06:39:59 INFO - moznetwork == 0.27 06:39:59 INFO - mozprocess == 0.22 06:39:59 INFO - mozprofile == 0.28 06:39:59 INFO - mozrunner == 6.11 06:39:59 INFO - mozscreenshot == 0.1 06:39:59 INFO - mozsystemmonitor == 0.0 06:39:59 INFO - moztest == 0.7 06:39:59 INFO - mozversion == 1.4 06:39:59 INFO - psutil == 3.1.1 06:39:59 INFO - requests == 1.2.3 06:39:59 INFO - wsgiref == 0.1.2 06:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:59 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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39:59 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 06:39:59 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 06:39:59 INFO - Using env: {'DISPLAY': ':0', 06:39:59 INFO - 'HOME': '/home/cltbld', 06:39:59 INFO - 'LANG': 'en_US.UTF-8', 06:39:59 INFO - 'LANGUAGE': 'en_US:en', 06:39:59 INFO - 'LOGNAME': 'cltbld', 06:39:59 INFO - 'MAIL': '/var/mail/cltbld', 06:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:59 INFO - 'MOZ_NO_REMOTE': '1', 06:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:59 INFO - 'NO_EM_RESTART': '1', 06:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:59 INFO - 'PWD': '/builds/slave/test', 06:39:59 INFO - 'SHELL': '/bin/bash', 06:39:59 INFO - 'SHLVL': '1', 06:39:59 INFO - 'TERM': 'linux', 06:39:59 INFO - 'TMOUT': '86400', 06:39:59 INFO - 'USER': 'cltbld', 06:39:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:59 INFO - '_': '/tools/buildbot/bin/python'} 06:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39: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)) 06:39:59 INFO - Cleaning up... 06:39:59 INFO - Return code: 0 06:39:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39: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')]} 06:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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')]} 06:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:39: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 06:39: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 06:39:59 INFO - Using env: {'DISPLAY': ':0', 06:39:59 INFO - 'HOME': '/home/cltbld', 06:39:59 INFO - 'LANG': 'en_US.UTF-8', 06:39:59 INFO - 'LANGUAGE': 'en_US:en', 06:39:59 INFO - 'LOGNAME': 'cltbld', 06:39:59 INFO - 'MAIL': '/var/mail/cltbld', 06:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:59 INFO - 'MOZ_NO_REMOTE': '1', 06:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:59 INFO - 'NO_EM_RESTART': '1', 06:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:59 INFO - 'PWD': '/builds/slave/test', 06:39:59 INFO - 'SHELL': '/bin/bash', 06:39:59 INFO - 'SHLVL': '1', 06:39:59 INFO - 'TERM': 'linux', 06:39:59 INFO - 'TMOUT': '86400', 06:39:59 INFO - 'USER': 'cltbld', 06:39:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:59 INFO - '_': '/tools/buildbot/bin/python'} 06:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:59 INFO - Downloading/unpacking jsonschema 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:39: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 06:40:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:40:01 INFO - Downloading/unpacking functools32 (from jsonschema) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:40:02 INFO - warning: no files found matching '*.txt' 06:40:02 INFO - no previously-included directories found matching 'build' 06:40:02 INFO - no previously-included directories found matching 'dist' 06:40:02 INFO - no previously-included directories found matching '.git*' 06:40:02 INFO - Installing collected packages: jsonschema, functools32 06:40:02 INFO - Running setup.py install for functools32 06:40:02 INFO - warning: no files found matching '*.txt' 06:40:02 INFO - no previously-included directories found matching 'build' 06:40:02 INFO - no previously-included directories found matching 'dist' 06:40:02 INFO - no previously-included directories found matching '.git*' 06:40:02 INFO - Successfully installed jsonschema functools32 06:40:02 INFO - Cleaning up... 06:40:02 INFO - Return code: 0 06:40:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:40:02 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 0x7faef765ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, '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': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', '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 06:40:02 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 06:40:02 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 06:40:02 INFO - Using env: {'DISPLAY': ':0', 06:40:02 INFO - 'HOME': '/home/cltbld', 06:40:02 INFO - 'LANG': 'en_US.UTF-8', 06:40:02 INFO - 'LANGUAGE': 'en_US:en', 06:40:02 INFO - 'LOGNAME': 'cltbld', 06:40:02 INFO - 'MAIL': '/var/mail/cltbld', 06:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:02 INFO - 'MOZ_NO_REMOTE': '1', 06:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:02 INFO - 'NO_EM_RESTART': '1', 06:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:02 INFO - 'PWD': '/builds/slave/test', 06:40:02 INFO - 'SHELL': '/bin/bash', 06:40:02 INFO - 'SHLVL': '1', 06:40:02 INFO - 'TERM': 'linux', 06:40:02 INFO - 'TMOUT': '86400', 06:40:02 INFO - 'USER': 'cltbld', 06:40:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:02 INFO - '_': '/tools/buildbot/bin/python'} 06:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:40:02 INFO - Downloading/unpacking flake8 06:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:40:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:40:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:40:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40: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 06:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:05 INFO - no previously-included directories found matching 'docs/_build' 06:40:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:40:05 INFO - Running setup.py install for pep8 06:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:40:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:40:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:40:05 INFO - no previously-included directories found matching 'docs/_build' 06:40:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:40:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:40:05 INFO - Cleaning up... 06:40:05 INFO - Return code: 0 06:40:05 INFO - Running post-action listener: _resource_record_post_action 06:40:05 INFO - Running post-action listener: _start_resource_monitoring 06:40:05 INFO - Starting resource monitoring. 06:40:05 INFO - ##### 06:40:05 INFO - ##### Running install step. 06:40:05 INFO - ##### 06:40:05 INFO - Running pre-action listener: _resource_record_pre_action 06:40:05 INFO - Running main action method: install 06:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:40:05 INFO - Reading from file tmpfile_stdout 06:40:05 INFO - Detecting whether we're running mozinstall >=1.0... 06:40:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:40:05 INFO - Reading from file tmpfile_stdout 06:40:05 INFO - Output received: 06:40:05 INFO - Usage: mozinstall [options] installer 06:40:05 INFO - Options: 06:40:05 INFO - -h, --help show this help message and exit 06:40:05 INFO - -d DEST, --destination=DEST 06:40:05 INFO - Directory to install application into. [default: 06:40:05 INFO - "/builds/slave/test"] 06:40:05 INFO - --app=APP Application being installed. [default: firefox] 06:40:05 INFO - mkdir: /builds/slave/test/build/application 06:40: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'] 06:40: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 06:40:21 INFO - Reading from file tmpfile_stdout 06:40:21 INFO - Output received: 06:40:21 INFO - /builds/slave/test/build/application/firefox/firefox 06:40:21 INFO - Running post-action listener: _resource_record_post_action 06:40:21 INFO - ##### 06:40:21 INFO - ##### Running run-tests step. 06:40:21 INFO - ##### 06:40:21 INFO - Running pre-action listener: _resource_record_pre_action 06:40:21 INFO - Running main action method: run_tests 06:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:40:21 INFO - Python 2.7.3 06:40:21 INFO - Return code: 0 06:40:21 INFO - grabbing minidump binary from tooltool 06:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:40:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/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 0x2747410>, '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 0x2748310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27487a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:40:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:40:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:40:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:40:21 INFO - Return code: 0 06:40:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:40:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:40:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:40:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:40:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:40:22 INFO - Return code: 0 06:40:22 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:40:22 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:40:22 INFO - Using env: {'DISPLAY': ':0', 06:40:22 INFO - 'HOME': '/home/cltbld', 06:40:22 INFO - 'LANG': 'en_US.UTF-8', 06:40:22 INFO - 'LANGUAGE': 'en_US:en', 06:40:22 INFO - 'LOGNAME': 'cltbld', 06:40:22 INFO - 'MAIL': '/var/mail/cltbld', 06:40:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:40:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:40:22 INFO - 'MOZ_NO_REMOTE': '1', 06:40:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:40:22 INFO - 'NO_EM_RESTART': '1', 06:40:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:40:22 INFO - 'PWD': '/builds/slave/test', 06:40:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:40:22 INFO - 'SHELL': '/bin/bash', 06:40:22 INFO - 'SHLVL': '1', 06:40:22 INFO - 'TERM': 'linux', 06:40:22 INFO - 'TMOUT': '86400', 06:40:22 INFO - 'USER': 'cltbld', 06:40:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091', 06:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:40:22 INFO - '_': '/tools/buildbot/bin/python'} 06:40:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:40:22 INFO - mozversion application_buildid: 20160503034638 06:40:22 INFO - mozversion application_changeset: d4e57dcb78d71fffd6b33088a11e051a294e5c14 06:40:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:40:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:40:22 INFO - mozversion application_name: Firefox 06:40:22 INFO - mozversion application_remotingname: firefox-dev 06:40:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:40:22 INFO - mozversion application_vendor: Mozilla 06:40:22 INFO - mozversion application_version: 48.0a2 06:40:22 INFO - mozversion platform_buildid: 20160503034638 06:40:22 INFO - mozversion platform_changeset: d4e57dcb78d71fffd6b33088a11e051a294e5c14 06:40:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:40:22 INFO - mozversion platform_version: 48.0a2 06:40:22 INFO - using testdate: 1462282822 06:40:22 INFO - actual date: 1462282822 06:40:22 INFO - starting webserver on 'localhost:48213' 06:40:22 INFO - SUITE-START | Running 2 tests 06:40:22 INFO - TEST-START | dromaeo_css 06:40:22 INFO - operating with platform_type : linux_ 06:40:22 INFO - Initialising browser for dromaeo_css test... 06:40:22 INFO - TEST-INFO | started process 6556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpok5bMA/profile http://localhost:48213/getInfo.html) 06:40:26 INFO - PROCESS | 6556 | 06:40:26 INFO - PROCESS | 6556 | (process:6637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:40:27 INFO - PROCESS | 6556 | __metrics Screen width/height:1600/1200 06:40:27 INFO - PROCESS | 6556 | colorDepth:24 06:40:27 INFO - PROCESS | 6556 | Browser inner width/height: 1024/697 06:40:27 INFO - PROCESS | 6556 | __metrics 06:40:27 ERROR - PROCESS | 6556 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:40:28 INFO - TEST-INFO | 6556: exit 0 06:40:28 INFO - Browser initialized. 06:40:28 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:28 INFO - TEST-INFO | started process 6688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpok5bMA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:30 INFO - PROCESS | 6688 | 06:40:30 INFO - PROCESS | 6688 | (process:6759): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:40:40 INFO - PROCESS | 6688 | RSS: Main: 152694784 06:40:40 INFO - PROCESS | 6688 | 06:41:29 INFO - PROCESS | 6688 | 1462282889856 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] 06:43:37 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48213/tests/dromaeo/cssquery-ext.html) 06:43:38 INFO - PROCESS | 6688 | RSS: Main: 156422144 06:43:38 INFO - PROCESS | 6688 | 06:46:40 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-ext.html (next: http://localhost:48213/tests/dromaeo/cssquery-jquery.html) 06:46:40 INFO - PROCESS | 6688 | RSS: Main: 154071040 06:46:40 INFO - PROCESS | 6688 | 06:49:42 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48213/tests/dromaeo/cssquery-mootools.html) 06:49:43 INFO - PROCESS | 6688 | RSS: Main: 153903104 06:49:43 INFO - PROCESS | 6688 | 06:52:44 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48213/tests/dromaeo/cssquery-prototype.html) 06:52:45 INFO - PROCESS | 6688 | RSS: Main: 153677824 06:52:45 INFO - PROCESS | 6688 | 06:55:47 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48213/tests/dromaeo/cssquery-yui.html) 06:55:48 INFO - PROCESS | 6688 | RSS: Main: 153952256 06:55:48 INFO - PROCESS | 6688 | 06:58:50 INFO - PROCESS | 6688 | Cycle 1(1): loaded http://localhost:48213/tests/dromaeo/cssquery-yui.html (next: http://localhost:48213/tests/dromaeo/cssquery-dojo.html) 06:58:51 INFO - PROCESS | 6688 | RSS: Main: 155406336 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | __start_tp_report 06:58:51 INFO - PROCESS | 6688 | _x_x_mozilla_page_load 06:58:51 INFO - PROCESS | 6688 | _x_x_mozilla_page_load_details 06:58:51 INFO - PROCESS | 6688 | |i|pagename|runs| 06:58:51 INFO - PROCESS | 6688 | |0;dojo.html;3371.410003249431;3464.8267586620664;3481.2689335239593;3485.424904890693;3514.2971405718863;5654.264945557082;5678.233438485809;5704.429557044294;5719.485246327829;5722.370539240691;5684.37471878093;5689.459501347375;5726.7422965966525;5731.570132240078;5757.740901659425;5067.7212753298645;5146.40816306124;5199.324087868572;5224.843254702365;5234.816781412651;5104.489551044884;5187.766550505236;5251.894962100756;5273.973630131844;5311.521963023327;5131.615128865331;5156.948430515685;5171.87070323243;5177.171652535595;5187.662801917863;5094.92357614638;5142.254373115896;5152.9484705152845;5176.327077479941;5188.92216616751;4969.751512424365;5062.1141300272675;5066.594672426234;5083.034223497523;5093.974530127362;5392.137258038695;5419.945800541984;5453.318335208099;5455.099908515091;5464.972675136639;6007.549433792483;6017.608855424427;6020.819375418744;6032.27612686476;6035;5994.880102397971;6022.909656355158;6107.664078475682;6133.417325354084;6162.568620196588;5761.567882408836;5767.279090113736;5773.971130144322;5775.3935836736955;5779.595428320019;6200.875982480326;6302.936970630327;6303.558750887394;6311.084892690534;6313.273973493107;5957.880842383128;5983.640981541122;6029.487493563096;6049.18336024631;6077.665728384893;6082.847928801815;6092.72582733778;6120.17377654011;6125.938740612626;6130.877382452415;5928.851778705481;6089;6104.175936248638;6117.785877494266;6120.7551697931585;5931.436513531207;5982.4017598239825;5985.670788106609;5995.280566332068;6021.638701677914;4524.7511386873375;4580.610648094883;4584.6561507887045;4597.678162528591;4603.723776573416;4067.5322337930925;4078.0416602098485;4098.467199264077;4112.424260603518;4163.708540402143;5784.508316793035;5849.970750146307;5944.494717949023;5960.135780311917;6031.336552979256;5913.940860591425;5943.286805583271;5962.105684147413;5977.222961015127;5986.610870293417;5717.742701578439;5766.365699773021;5784.161296612052;5785;5865.35481097079;5130.358705161855;5133.8716532087;5143.099957507496;5174.844754657366;5181.81863634771;6380.585261957958;6398.104265402847;6410.8076757697345;6411.711472983727;6415.166028416276;5957.165996760544;6116.969415152985;6121.540884433596;6135.447809697149;6159.630422174684;6187.783427580013;6195.566310358232;6199.752009919553;6210.720517576629;6230.314665386894;5840.503557197516;5858.121281807763;5870.090136028923;5888.440598143169;5895.469407753323;5914.497267732291;5959.523238141025;6060.878782424239;6116.457510225511;6150.384961503813;5996.130561068708;6003.099535069775;6024.668643224665;6028.186194863637;6029.728662210124;5894.823155305347;5935.139404786196;5964.224650795369;5972.8805423892145;5982.46157845796;5808.39011903744;5876;5927.081302398135;5944.762209511744;5983.7008149591475;5990.4908082813445;5994.730237139426;6006.339302676614;6010.398960104129;6037.15479832815;5645.576581756302;5898.498627616701;5899.46904778572;5900.055991041413;5907.40925907423 06:58:51 INFO - PROCESS | 6688 | |1;ext.html;660.3557142714639;674.0058413839586;683.1255992329814;683.5830143612397;744.9830980711331;33664.326713465714;40262;40994.180116397656;41122.38316425248;41381.13784879684;43987;44762.77618611902;44922.77538612302;45050.774746126306;45122.774386128025;8744.825103497926;8973.95513022434;8980.057094005133;9013.864792028126;9033.683821066264;8660.437071590326;8770.254528365096;8776.780580485507;8828.779280518007;8944.150305720947;8831.911680883206;8909.95545022274;8916.108389161096;8917.73246802597;8942.329325300596;8966.730998070036;8993.55032248385;9038.954805225965;9042.999999999967;9061;9030.86453703195;9101.226395756368;9128.269738420977;9185.081491850828;9199.54002299889;45050.09899801986;45553.772231138966;45687.771561141984;45819.77090114528;45844;3836.712246581518;3948.6248806363637;3984.6812255019527;4001.7598944063448;4563.06457176278;33165;34178;34487.6551234487;34702.6529734702;35600.643993560254;4424.867253982386;4523.208438523246;4523.532181714514;4541.386912766768;4572.51988541205;329078;330866;331676;333360;333956.99999999756;62138.68930655408;62165.06752398718;62390.376096238455;62437.375626243156;62447;61082.38917610767;62023.37976620176;62431.37568624347;62770.37229627737;65014.67492662601;18297.268109275745;18692.7196092056;18702.906485467487;18719.157637906326;18756.53108672267;14344.49794257196;14434.206118663575;14442.927785361006;14454.1327520347;14474.348654310581;20678.276260330815;20832.1667133313;20896.268630597857;20977;21069.578608427746;7928.841423171504;8178.877316840252;8192.425344506328;8201.95899020501;8371.58142092893;1139.3179005134825;1149.2759561476216;1157.8147496400704;1175.7178277213407;1199.6161228406827;33194.170145746066;33235.33529329448;33297.50053749196;33588.328233435685;33898.32203355919;1180.2741314091943;1187.4597058338436;1189.3874654552912;1220.9389530523438;1234.234774439853;17819.287228510715;17862.19620117098;17893.910530447265;18045.368412105778;18324.541886452946;310920;320302;323754;325811;496220;62371.688141559;63269;63493.047604285974;63496.36503634997;64082.35917640857;1494.521753039017;1499.078066988794;1500.752375857993;1509.0870023635543;1512.296781996377;32464.188395290308;32705;33176.83411582927;33231;33917.66082339145;53786.19320710114;54184;54298.45701543092;54635.726821365635;54663.72668136634;374345;375027;375410;375780;377320;30613;31010;42441.787791060844;43339.13321733611;43398.56601433945;44964.77517612391;46703.29945050759;46704.29943550781;46706.76646616745;47401.52598473971;40884.79557602312;41869.162616746886;42612.14775704406;42739.78630106829;43091;40500.3924941132;40902.59097408988;40924.79537602412;41449.585504145776;42219.36670949877;40874.59125408708;41455;41937;42009;42033.57966420419;36350.27299454049;36352.462088090964;36557;36722.816385918966;37182.256354873294;27435.765390557073;28131.296717582223;28951.796940930803;28973.696183671364;29535.55696664595 06:58:51 INFO - PROCESS | 6688 | |2;jquery.html;429.63695677152793;433.64224514775316;434.5220257716511;436.9322754972976;438.11500768447735;18807.247710091597;18847.246110155593;19502.317418890343;19536.70694939577;19566.90216548917;18475.35336263231;18573.53566160847;18675;18858;19401.708974365396;5649.519790817775;6085.695715214244;6094.451499365056;6099.359567245419;6104.359042300561;5844.561657875655;5911.379305172959;6044.455998960093;6052.303985041711;6060.030395136779;5986.8802623947495;5993.550483713717;6013.338532761392;6019.1874096997;6031.095335699636;5722.427757224306;5893.911591326134;5930.792422265243;5967.283925928895;5982.491488223506;5268.130758424893;5303.257543943851;5309.840704778863;5320.388155362106;5345.091334473149;23365.766342336698;23932.401689957715;24463.63304550433;24501.877490612434;24610.630840537407;2552.527782360269;2571.2543362424876;2599.974000259992;2762.2127693607426;2769.9751092096053;14306.141631502143;14973.176475293854;15399.384024639001;15436.228188590525;15782.921085394615;2045.427280361501;2066.617675729995;2101.159536185523;2138.8395870309787;2210.071769856664;61608.4597885052;81752;82625.58687206586;83575;88071.55964220202;10635.52140153695;11362.659120226406;11373.431328433711;11970.22193557416;12442.37788110591;17026.574335641708;17039.48881533556;17114.828851711325;17154.742678859828;17183.484495464905;9187.862182067274;9265.2124569411;9279.39683920543;9331;9345;8908.73273801787;8976.102389761103;9066.365354425126;9067.773305667411;9095.590698418588;5016.673916195508;5140;5172.948270517322;5228.790848366023;5272.446393128666;2092.571022940324;2101.642720737478;2114.186038375206;2153.8169255613448;2205.8455908086603;1078.0243879289255;1080.1952545353604;1105.3202280597375;1158.959436419738;1178.8762179971152;17795;19596.314129005415;19854.60290794176;20351.69472457914;20907.895460522905;1070.817960946641;1071.5124618298655;1085.267444474992;1133.4219548030399;1142.5715356741223;11208.15938804593;11270.605528806453;11341.319520828776;11412.258203216765;11543.71140721472;558031;571816;582445;593892;604192;81624;99844;103681;104509;105664.47167764112;1073.6939972108069;1112.4826955465746;1120.7198200449889;1127.22784892349;1128.5993472317373;16891.32434702598;17155.828441715923;17249.56876078108;17299.30802767875;17432.30270789205;41684.58315416807;41948.580514194466;43261.567384325754;45456.772716136205;46611.53388466072;56718;58196.4180358191;59211;63409;64760;13261.734765304447;13522;13586.79619805684;13625.86374136246;13886.444542218198;14684.118952862862;15094.094354338775;15137.924310378377;15266.770998435255;15550.844491554939;12841.743165136832;12861.164024338388;12979.41592628315;13069.085164038426;13891.235982020682;8592.140785921358;8943.597538110671;9004.189622933967;9026.954865225633;12440.377981100728;8979.416337938013;8994.010658827654;9020.188183063556;9098.499582523025;9147.725568232963;13272.46910123623;13491.190528568317;13494.055416120776;13548.86451135476;13562.254076025913;12764.936175319064;13171.341432928506;13228.801567976681;13254.337283135612;13295.069345145746 06:58:51 INFO - PROCESS | 6688 | |3;mootools.html;1599.1684324151443;1643.6959162554929;1874.737536744856;1904.400113964102;1969.1335812242603;7792.181820908808;8573.699920502784;8625.22372986431;8892.021877593468;8944.195022447979;8580;8644.783880402993;8699.95650021749;8716.302695784338;8748.475091494514;2266.841321107519;2272.8977196026217;2286.554121946221;2294.3575798776287;2297.2993237062688;2375.643653451979;2378.916737914173;2430.2952143878256;2446.107170882624;2454.5949918263555;2331.650252462136;2354.8469349492316;2372.217168334454;2409.277216834951;2412.9155479558217;2371.1819422299277;2376.287113865842;2378.15575470708;2384.43965668067;2405.9398515037087;2264.615015447378;2282.3038973113194;2313.2828823064906;2321.7330007049068;2324.1052194905083;8995.415298005608;9031.819363612756;9048.457092574467;9085.77285567866;9087.863682044775;5185.170372740344;5318.202269659543;5342.439043900374;5374.677519348852;5376.865578360533;3332.6167490738635;3333.799972001688;3398.575178102737;3431.9656803431894;3469.3581687387664;1127.4362818590705;1131.9830202546968;1151.8732939376662;1192.3322939154102;1195.1394995603152;12320.137590368679;12350.25898446105;12393.194442361308;12435.44040518179;12448.62654120378;4707.693999889996;4778.665493415428;4804.124323415052;4844.709317440965;4956.727379994063;10344.32761870476;10392.844107338396;10396.324238924446;10402.5838966442;10406.791864162826;5403.243545903577;5436.130219164915;5464.617476776588;5478.205660179252;5509.807156749494;4334.544872788375;4946.208606622995;4969.229769385751;5141.177411614124;5152.974235128875;4273.358996150602;4301.41930839339;4309.741415515079;4368.8907777305185;4373.868783936487;1394.219237227156;1402.193738600309;1410.104583589428;1410.4428750643438;1429.535400994681;880.8942926848691;936.9063093690577;1055.4195192644015;1063.2450959818461;1074.3768614203743;5961.761529538857;6018.337982821886;6053.818385448443;6070.605410648293;6169;438.6052552702593;452.030394803152;456.5320546439926;459.8367579509226;461.59379745824134;4333.566643335641;4354.628292087982;4386.495553011381;4390.165868484977;4394.209042372339;10844.13246940243;11358.886411135949;11400.144989125849;11402.429878506042;11412.543498260142;11107.38909359993;11160.944195278971;11168.66494005181;11238.100951923827;11252;7935.285824275843;8317.667293308321;8318.875216871631;8330.541820199947;8475.49147051179;5911.142884281841;6108.8778224436155;6124;6240.875182496234;6276.905846412216;9988.750281242736;10212.387256764618;10390.116840068678;10440.060394564525;10556.208284378548;10397.53211105487;10573.259871809207;10591;10622.415767132881;10642.308249963728;7769.922300777146;8397.160283971554;8402.663893444194;8518.61666225009;8613.956930215309;8665.956670216608;8710.564471776512;8766.474011559327;8810.691625793066;8812.250958668328;7721.7683469496005;8070.803182345265;8234.547099909563;8245.752627420947;8319.459235149696;7837.6081195941115;8111.675532978615;8114.797130071795;8123.83752324962;8166.142555031636;7433.331000210007;7488.775336739906;7515.436342274461;7532.7740167795055;7578.43161762881;5333.386660533933;5347.064263753905;5482;5524.530414914777;5585.720713964367;5215.139501982282;5242.711650859087;5338.519533242027;5418.160185171305;5447.182922561489 06:58:51 INFO - PROCESS | 6688 | |4;prototype.html;353.2229095988825;357.3264396612385;362.5794078868513;364.6317219608195;366.12313509145616;5688.345840228375;5789.481575514654;5817.796377126801;5826.592138550303;5864.618799778012;5603.103503439451;5717.685527295997;5736.655800651964;5742.310922689273;5743.5118014968775;4418.238600874453;4421.513633500304;4432.15789000089;4432.867013989586;4454.354118652794;4429.46846378435;4436.511983681792;4446.933296000562;4448.266036104039;4451.62161216297;4397.824087036531;4414.889627759316;4423.601875831175;4429.55704429556;4443.488998765135;4326.221280169569;4382.715123516993;4390.40729501518;4396.692231543793;4424.40270563473;3878.825452854628;3880.4955355803845;3894.143288476559;3903.4730311408166;3908;5498.862528436781;5514.558835293167;5517.172424136412;5546.889062218774;5548.446434998207;4993.850184494471;5066.797328106872;5091.287219789232;5091.592672586185;5119.59043276537;5981.910271345933;5995.040793473024;5999.89002034625;6007.399260074001;6030.909536356959;4327.156204540116;4337.63130133939;4344.435223420966;4354.608085272309;4373.497047839507;5927.673977931212;6078.756849726005;6230.470410015154;6257.5619706620555;6269.843253918643;4295.806688699016;4308.849190278325;4313.525512193656;4339.1972485090355;4344.500382456058;4377.956220437819;4379.693421460467;4383.758893260838;4391.626711729538;4397.8240870364825;4944.579710724557;4958.925466210972;5019.820342219576;5035.640377098163;5054.241863720398;5957.463828255478;5968.46283834457;5984.1921340618455;6017.939820601826;6027.969860150672;1571.1515781477874;1572.4889410941262;1573.7245981953342;1578.2345562402227;1582.9920850395674;1064.5156453813497;1091.3997301484153;1093.8632670916136;1096.6490722968733;1096.961606343774;6208.317085120633;6236.345183755731;6245.313015568284;6285.9057114143325;6304.211973503312;6545.800769627397;6552.475801935833;6586.85927073703;6593.571417857824;6617.933820661828;6137.5703700741415;6237.157983672146;6248.593841400295;6264.749410023639;6296.212973378328;3504;3538.327717733622;3547.769394989369;3548.822558872046;3562.750607457453;6761.560498567577;6777.542828291941;6904.723811047602;6910.412614927787;6918.654067296615;6747.865042699119;6772.627505487147;6783.998720377501;6785.830354241085;6799.286074962157;6734.629595372302;6834.3687680243465;6845.349691779273;6856.897146542806;6955.408790252784;6590.275069742229;6610.2398224204835;6622.1722284714415;6639.568428052161;6656.7670131545165;6345.524085693499;6504.284528701934;6513.54405191632;6545.574537655038;6584.407403333723;6311.558190926591;6450.29067297176;6472.546921715623;6483.902741458976;6527.15147030883;4437.622802061861;4554.499005109502;4563.680542362003;4576.382188404523;4592.7014744041535;6154.9384506154365;6223.813285601439;6249.312575616587;6270.905936410866;6289.874202516015;5979.1928089707335;5986.790462333797;6042.456178943916;6083.878322433615;6107.6640784757265;5863.824085277449;6022.247219097613;6059.8790423351475;6078.7872424466705;6081.817545473643;5943.910841337297;5946.910796338145;5952.672603006876;5978.461938425563;5979.730912109053;6003.579749417673;6106.511479081574;6117.449429551361;6117.785877494266;6125.540584456273;5750.25246717924;5854.326752423526;5872.794452194153;5874.706264686834;5904.9075920954765 06:58:51 INFO - PROCESS | 6688 | |5;yui.html;794.9244821741936;812.1878121878121;820;825.0923983618019;829.1294141151797;13774.44902203913;14177.929110354435;14389.2805359732;14515.56453306401;14581.270936453175;13893;13958.51145209918;14111;14127.92936035321;14151;887.5872719185561;923.5336155241594;924.1636319131163;928.1878356438117;933.6685476655791;920.2132176988679;924.1867156901917;928.5867788833938;929.8744669469636;930.9813803723921;965.5413678502725;967.666155176463;972.5283237629744;975.1370037516813;978.5107446276861;966.1304825656965;967.2552134856121;968.4334664221439;968.5883499512679;970.8009857979133;709.992900071003;711.121764620693;711.9323664251888;713.2617740638466;718.396546900606;15968.600784980352;15997.120158391284;16029.759553606706;16074.839251607451;16110.11394373309;13969;14018.228997405138;14519.854801451957;14704.926475367554;14837;11649.650510484698;11747.29516229029;11839.704007399798;11980.70048248792;12171.93914030433;3839.4432807242792;3929.7445666031617;3964.444977703095;3967.3255546557157;4019.638232559084;56088.43911560873;56624;56714;57385.13922291169;60058.09912851311;11464.140189485823;11504.76990460186;11741.354225517507;11813.291202527877;12006.759864802654;19408.611827763365;19438.4168474946;19670.31153909635;19791.30730424428;19950.20199192045;8632.136786321318;8718.258947989365;8728.563571821383;8741.737747867573;9091.590878410487;4967.130752118364;5027.748612569357;5099.56653684441;5141.074606570854;5154;3634.9636503635156;3645.854165833337;3834.731568790158;3852.8266228019247;3860.749051311656;721.6788529104498;726.1068885271146;732.3701616609818;736.8194792275926;740.7333359990399;622.7508996401476;646.5506473001219;653.6568301641581;714.2857142857143;714.5212707485997;8878.86681699775;8927.571588545932;8987.865182022275;8999.100089990949;9243.76890577741;709.2092317066433;732.974345897891;747.8354761952362;767.3784234769743;772.4129661457333;4320.157569273962;4388.078503514298;4406.537313582027;4433.977830110829;4506.774661266923;61000;61308.38691613116;61982.140535784;62235.37764622296;64403;61885;63193.684031580466;63374;63485;63640.68179659165;54838.72580637151;55407.722961384934;56624.43375566274;56899.14651280234;59934.400655993755;9092.221674557884;9419.480881942594;9568.712938611852;9618.615255389706;9637.325387222827;33381.33237335288;34217;34728.13179670528;34792.47811282782;34874.30251395009;45473.31790023086;49002;49029;49440.25839612481;49743.25385119153;12232.694182645506;12873.549425770054;13115.672108197372;13179.868201318248;13329.200247985153;12879.484820607071;13395.866041339852;13606.25165615861;13620.38708258111;15442.691146176789;13121.934390327988;13614.455421783414;13736.244506552235;14482.565523034325;14501.129932204101;13076.476940922637;13729.970252230924;13748.243846588533;13933.094348867291;13978.231197284247;12109.273443593413;12349.876501234872;12765.61703148907;12801.29592872401;13016.674583135497;10861.837072443761;10869.402182880018;11246.381449020382;11520.53917843277;11601.941990290332;10387;11188.496517656888;11374.374409407563;11519.654410367702;11546.538138474367 06:58:51 INFO - PROCESS | 6688 | __end_tp_report 06:58:51 INFO - PROCESS | 6688 | __start_cc_report 06:58:51 INFO - PROCESS | 6688 | _x_x_mozilla_cycle_collect,325 06:58:51 INFO - PROCESS | 6688 | __end_cc_report 06:58:51 INFO - PROCESS | 6688 | __startTimestamp1462283931060__endTimestamp 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | ------- Summary: start ------- 06:58:51 INFO - PROCESS | 6688 | Number of tests: 6 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#0] dojo.html Cycles:165 Average:5644.71 Median:5899.47 stddev:635.31 (10.8%) stddev-sans-first:611.71 06:58:51 INFO - PROCESS | 6688 | Values: 3371.4 3464.8 3481.3 3485.4 3514.3 5654.3 5678.2 5704.4 5719.5 5722.4 5684.4 5689.5 5726.7 5731.6 5757.7 5067.7 5146.4 5199.3 5224.8 5234.8 5104.5 5187.8 5251.9 5274.0 5311.5 5131.6 5156.9 5171.9 5177.2 5187.7 5094.9 5142.3 5152.9 5176.3 5188.9 4969.8 5062.1 5066.6 5083.0 5094.0 5392.1 5419.9 5453.3 5455.1 5465.0 6007.5 6017.6 6020.8 6032.3 6035.0 5994.9 6022.9 6107.7 6133.4 6162.6 5761.6 5767.3 5774.0 5775.4 5779.6 6200.9 6302.9 6303.6 6311.1 6313.3 5957.9 5983.6 6029.5 6049.2 6077.7 6082.8 6092.7 6120.2 6125.9 6130.9 5928.9 6089.0 6104.2 6117.8 6120.8 5931.4 5982.4 5985.7 5995.3 6021.6 4524.8 4580.6 4584.7 4597.7 4603.7 4067.5 4078.0 4098.5 4112.4 4163.7 5784.5 5850.0 5944.5 5960.1 6031.3 5913.9 5943.3 5962.1 5977.2 5986.6 5717.7 5766.4 5784.2 5785.0 5865.4 5130.4 5133.9 5143.1 5174.8 5181.8 6380.6 6398.1 6410.8 6411.7 6415.2 5957.2 6117.0 6121.5 6135.4 6159.6 6187.8 6195.6 6199.8 6210.7 6230.3 5840.5 5858.1 5870.1 5888.4 5895.5 5914.5 5959.5 6060.9 6116.5 6150.4 5996.1 6003.1 6024.7 6028.2 6029.7 5894.8 5935.1 5964.2 5972.9 5982.5 5808.4 5876.0 5927.1 5944.8 5983.7 5990.5 5994.7 6006.3 6010.4 6037.2 5645.6 5898.5 5899.5 5900.1 5907.4 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#1] ext.html Cycles:180 Average:54146.41 Median:41452.29 stddev:93590.42 (225.8%) stddev-sans-first:93766.81 06:58:51 INFO - PROCESS | 6688 | Values: 660.4 674.0 683.1 683.6 745.0 33664.3 40262.0 40994.2 41122.4 41381.1 43987.0 44762.8 44922.8 45050.8 45122.8 8744.8 8974.0 8980.1 9013.9 9033.7 8660.4 8770.3 8776.8 8828.8 8944.2 8831.9 8910.0 8916.1 8917.7 8942.3 8966.7 8993.6 9039.0 9043.0 9061.0 9030.9 9101.2 9128.3 9185.1 9199.5 45050.1 45553.8 45687.8 45819.8 45844.0 3836.7 3948.6 3984.7 4001.8 4563.1 33165.0 34178.0 34487.7 34702.7 35600.6 4424.9 4523.2 4523.5 4541.4 4572.5 329078.0 330866.0 331676.0 333360.0 333957.0 62138.7 62165.1 62390.4 62437.4 62447.0 61082.4 62023.4 62431.4 62770.4 65014.7 18297.3 18692.7 18702.9 18719.2 18756.5 14344.5 14434.2 14442.9 14454.1 14474.3 20678.3 20832.2 20896.3 20977.0 21069.6 7928.8 8178.9 8192.4 8202.0 8371.6 1139.3 1149.3 1157.8 1175.7 1199.6 33194.2 33235.3 33297.5 33588.3 33898.3 1180.3 1187.5 1189.4 1220.9 1234.2 17819.3 17862.2 17893.9 18045.4 18324.5 310920.0 320302.0 323754.0 325811.0 496220.0 62371.7 63269.0 63493.0 63496.4 64082.4 1494.5 1499.1 1500.8 1509.1 1512.3 32464.2 32705.0 33176.8 33231.0 33917.7 53786.2 54184.0 54298.5 54635.7 54663.7 374345.0 375027.0 375410.0 375780.0 377320.0 30613.0 31010.0 42441.8 43339.1 43398.6 44964.8 46703.3 46704.3 46706.8 47401.5 40884.8 41869.2 42612.1 42739.8 43091.0 40500.4 40902.6 40924.8 41449.6 42219.4 40874.6 41455.0 41937.0 42009.0 42033.6 36350.3 36352.5 36557.0 36722.8 37182.3 27435.8 28131.3 28951.8 28973.7 29535.6 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#2] jquery.html Cycles:180 Average:32491.79 Median:2146.33 stddev:95607.44 (4454.5%) stddev-sans-first:95845.33 06:58:51 INFO - PROCESS | 6688 | Values: 429.6 433.6 434.5 436.9 438.1 18807.2 18847.2 19502.3 19536.7 19566.9 18475.4 18573.5 18675.0 18858.0 19401.7 5649.5 6085.7 6094.5 6099.4 6104.4 5844.6 5911.4 6044.5 6052.3 6060.0 5986.9 5993.6 6013.3 6019.2 6031.1 5722.4 5893.9 5930.8 5967.3 5982.5 5268.1 5303.3 5309.8 5320.4 5345.1 23365.8 23932.4 24463.6 24501.9 24610.6 2552.5 2571.3 2600.0 2762.2 2770.0 14306.1 14973.2 15399.4 15436.2 15782.9 2045.4 2066.6 2101.2 2138.8 2210.1 61608.5 81752.0 82625.6 83575.0 88071.6 10635.5 11362.7 11373.4 11970.2 12442.4 17026.6 17039.5 17114.8 17154.7 17183.5 9187.9 9265.2 9279.4 9331.0 9345.0 8908.7 8976.1 9066.4 9067.8 9095.6 5016.7 5140.0 5172.9 5228.8 5272.4 2092.6 2101.6 2114.2 2153.8 2205.8 1078.0 1080.2 1105.3 1159.0 1178.9 17795.0 19596.3 19854.6 20351.7 20907.9 1070.8 1071.5 1085.3 1133.4 1142.6 11208.2 11270.6 11341.3 11412.3 11543.7 558031.0 571816.0 582445.0 593892.0 604192.0 81624.0 99844.0 103681.0 104509.0 105664.5 1073.7 1112.5 1120.7 1127.2 1128.6 16891.3 17155.8 17249.6 17299.3 17432.3 41684.6 41948.6 43261.6 45456.8 46611.5 56718.0 58196.4 59211.0 63409.0 64760.0 13261.7 13522.0 13586.8 13625.9 13886.4 14684.1 15094.1 15137.9 15266.8 15550.8 12841.7 12861.2 12979.4 13069.1 13891.2 8592.1 8943.6 9004.2 9027.0 12440.4 8979.4 8994.0 9020.2 9098.5 9147.7 13272.5 13491.2 13494.1 13548.9 13562.3 12764.9 13171.3 13228.8 13254.3 13295.1 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#3] mootools.html Cycles:180 Average:5962.37 Median:458.18 stddev:3376.34 (736.9%) stddev-sans-first:3369.89 06:58:51 INFO - PROCESS | 6688 | Values: 1599.2 1643.7 1874.7 1904.4 1969.1 7792.2 8573.7 8625.2 8892.0 8944.2 8580.0 8644.8 8700.0 8716.3 8748.5 2266.8 2272.9 2286.6 2294.4 2297.3 2375.6 2378.9 2430.3 2446.1 2454.6 2331.7 2354.8 2372.2 2409.3 2412.9 2371.2 2376.3 2378.2 2384.4 2405.9 2264.6 2282.3 2313.3 2321.7 2324.1 8995.4 9031.8 9048.5 9085.8 9087.9 5185.2 5318.2 5342.4 5374.7 5376.9 3332.6 3333.8 3398.6 3432.0 3469.4 1127.4 1132.0 1151.9 1192.3 1195.1 12320.1 12350.3 12393.2 12435.4 12448.6 4707.7 4778.7 4804.1 4844.7 4956.7 10344.3 10392.8 10396.3 10402.6 10406.8 5403.2 5436.1 5464.6 5478.2 5509.8 4334.5 4946.2 4969.2 5141.2 5153.0 4273.4 4301.4 4309.7 4368.9 4373.9 1394.2 1402.2 1410.1 1410.4 1429.5 880.9 936.9 1055.4 1063.2 1074.4 5961.8 6018.3 6053.8 6070.6 6169.0 438.6 452.0 456.5 459.8 461.6 4333.6 4354.6 4386.5 4390.2 4394.2 10844.1 11358.9 11400.1 11402.4 11412.5 11107.4 11160.9 11168.7 11238.1 11252.0 7935.3 8317.7 8318.9 8330.5 8475.5 5911.1 6108.9 6124.0 6240.9 6276.9 9988.8 10212.4 10390.1 10440.1 10556.2 10397.5 10573.3 10591.0 10622.4 10642.3 7769.9 8397.2 8402.7 8518.6 8614.0 8666.0 8710.6 8766.5 8810.7 8812.3 7721.8 8070.8 8234.5 8245.8 8319.5 7837.6 8111.7 8114.8 8123.8 8166.1 7433.3 7488.8 7515.4 7532.8 7578.4 5333.4 5347.1 5482.0 5524.5 5585.7 5215.1 5242.7 5338.5 5418.2 5447.2 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#4] prototype.html Cycles:180 Average:5175.50 Median:5859.08 stddev:1563.54 (26.7%) stddev-sans-first:1525.46 06:58:51 INFO - PROCESS | 6688 | Values: 353.2 357.3 362.6 364.6 366.1 5688.3 5789.5 5817.8 5826.6 5864.6 5603.1 5717.7 5736.7 5742.3 5743.5 4418.2 4421.5 4432.2 4432.9 4454.4 4429.5 4436.5 4446.9 4448.3 4451.6 4397.8 4414.9 4423.6 4429.6 4443.5 4326.2 4382.7 4390.4 4396.7 4424.4 3878.8 3880.5 3894.1 3903.5 3908.0 5498.9 5514.6 5517.2 5546.9 5548.4 4993.9 5066.8 5091.3 5091.6 5119.6 5981.9 5995.0 5999.9 6007.4 6030.9 4327.2 4337.6 4344.4 4354.6 4373.5 5927.7 6078.8 6230.5 6257.6 6269.8 4295.8 4308.8 4313.5 4339.2 4344.5 4378.0 4379.7 4383.8 4391.6 4397.8 4944.6 4958.9 5019.8 5035.6 5054.2 5957.5 5968.5 5984.2 6017.9 6028.0 1571.2 1572.5 1573.7 1578.2 1583.0 1064.5 1091.4 1093.9 1096.6 1097.0 6208.3 6236.3 6245.3 6285.9 6304.2 6545.8 6552.5 6586.9 6593.6 6617.9 6137.6 6237.2 6248.6 6264.7 6296.2 3504.0 3538.3 3547.8 3548.8 3562.8 6761.6 6777.5 6904.7 6910.4 6918.7 6747.9 6772.6 6784.0 6785.8 6799.3 6734.6 6834.4 6845.3 6856.9 6955.4 6590.3 6610.2 6622.2 6639.6 6656.8 6345.5 6504.3 6513.5 6545.6 6584.4 6311.6 6450.3 6472.5 6483.9 6527.2 4437.6 4554.5 4563.7 4576.4 4592.7 6154.9 6223.8 6249.3 6270.9 6289.9 5979.2 5986.8 6042.5 6083.9 6107.7 5863.8 6022.2 6059.9 6078.8 6081.8 5943.9 5946.9 5952.7 5978.5 5979.7 6003.6 6106.5 6117.4 6117.8 6125.5 5750.3 5854.3 5872.8 5874.7 5904.9 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - PROCESS | 6688 | [#5] yui.html Cycles:180 Average:15712.25 Median:47237.66 stddev:18334.10 (38.8%) stddev-sans-first:18351.30 06:58:51 INFO - PROCESS | 6688 | Values: 794.9 812.2 820.0 825.1 829.1 13774.4 14177.9 14389.3 14515.6 14581.3 13893.0 13958.5 14111.0 14127.9 14151.0 887.6 923.5 924.2 928.2 933.7 920.2 924.2 928.6 929.9 931.0 965.5 967.7 972.5 975.1 978.5 966.1 967.3 968.4 968.6 970.8 710.0 711.1 711.9 713.3 718.4 15968.6 15997.1 16029.8 16074.8 16110.1 13969.0 14018.2 14519.9 14704.9 14837.0 11649.7 11747.3 11839.7 11980.7 12171.9 3839.4 3929.7 3964.4 3967.3 4019.6 56088.4 56624.0 56714.0 57385.1 60058.1 11464.1 11504.8 11741.4 11813.3 12006.8 19408.6 19438.4 19670.3 19791.3 19950.2 8632.1 8718.3 8728.6 8741.7 9091.6 4967.1 5027.7 5099.6 5141.1 5154.0 3635.0 3645.9 3834.7 3852.8 3860.7 721.7 726.1 732.4 736.8 740.7 622.8 646.6 653.7 714.3 714.5 8878.9 8927.6 8987.9 8999.1 9243.8 709.2 733.0 747.8 767.4 772.4 4320.2 4388.1 4406.5 4434.0 4506.8 61000.0 61308.4 61982.1 62235.4 64403.0 61885.0 63193.7 63374.0 63485.0 63640.7 54838.7 55407.7 56624.4 56899.1 59934.4 9092.2 9419.5 9568.7 9618.6 9637.3 33381.3 34217.0 34728.1 34792.5 34874.3 45473.3 49002.0 49029.0 49440.3 49743.3 12232.7 12873.5 13115.7 13179.9 13329.2 12879.5 13395.9 13606.3 13620.4 15442.7 13121.9 13614.5 13736.2 14482.6 14501.1 13076.5 13730.0 13748.2 13933.1 13978.2 12109.3 12349.9 12765.6 12801.3 13016.7 10861.8 10869.4 11246.4 11520.5 11601.9 10387.0 11188.5 11374.4 11519.7 11546.5 06:58:51 INFO - PROCESS | 6688 | -------- Summary: end -------- 06:58:51 INFO - PROCESS | 6688 | 06:58:51 INFO - TEST-INFO | 6688: exit 0 06:58:51 INFO - TEST-OK | dromaeo_css | took 1109169ms 06:58:51 INFO - TEST-START | kraken 06:58:51 INFO - operating with platform_type : linux_ 06:58:51 INFO - Initialising browser for kraken test... 06:58:51 INFO - TEST-INFO | started process 6931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMyex3a/profile http://localhost:48213/getInfo.html) 06:58:55 INFO - PROCESS | 6931 | 06:58:55 INFO - PROCESS | 6931 | (process:7010): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:58:56 INFO - PROCESS | 6931 | __metrics Screen width/height:1600/1200 06:58:56 INFO - PROCESS | 6931 | colorDepth:24 06:58:56 INFO - PROCESS | 6931 | Browser inner width/height: 1024/697 06:58:56 INFO - PROCESS | 6931 | __metrics 06:58:56 ERROR - PROCESS | 6931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:58:57 INFO - TEST-INFO | 6931: exit 0 06:58:57 INFO - Browser initialized. 06:58:57 INFO - Running cycle 1/1 for kraken test... 06:58:57 INFO - TEST-INFO | started process 7061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMyex3a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:59 INFO - PROCESS | 7061 | 06:58:59 INFO - PROCESS | 7061 | (process:7132): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:09 INFO - PROCESS | 7061 | RSS: Main: 152125440 06:59:09 INFO - PROCESS | 7061 | 06:59:11 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48213/tests/kraken/driver.html?testName=audio-beat-detection) 06:59:12 INFO - PROCESS | 7061 | RSS: Main: 156921856 06:59:12 INFO - PROCESS | 7061 | 06:59:15 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48213/tests/kraken/driver.html?testName=audio-dft) 06:59:16 INFO - PROCESS | 7061 | RSS: Main: 157073408 06:59:16 INFO - PROCESS | 7061 | 06:59:18 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48213/tests/kraken/driver.html?testName=audio-fft) 06:59:19 INFO - PROCESS | 7061 | RSS: Main: 157290496 06:59:19 INFO - PROCESS | 7061 | 06:59:21 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48213/tests/kraken/driver.html?testName=audio-oscillator) 06:59:22 INFO - PROCESS | 7061 | RSS: Main: 157753344 06:59:22 INFO - PROCESS | 7061 | 06:59:24 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48213/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:59:25 INFO - PROCESS | 7061 | RSS: Main: 157499392 06:59:25 INFO - PROCESS | 7061 | 06:59:28 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48213/tests/kraken/driver.html?testName=imaging-darkroom) 06:59:28 INFO - PROCESS | 7061 | RSS: Main: 157954048 06:59:28 INFO - PROCESS | 7061 | 06:59:31 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48213/tests/kraken/driver.html?testName=imaging-desaturate) 06:59:32 INFO - PROCESS | 7061 | RSS: Main: 157876224 06:59:32 INFO - PROCESS | 7061 | 06:59:35 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48213/tests/kraken/driver.html?testName=json-parse-financial) 06:59:35 INFO - PROCESS | 7061 | RSS: Main: 157732864 06:59:35 INFO - PROCESS | 7061 | 06:59:37 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48213/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:59:38 INFO - PROCESS | 7061 | RSS: Main: 157716480 06:59:38 INFO - PROCESS | 7061 | 06:59:39 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:40 INFO - PROCESS | 7061 | RSS: Main: 157974528 06:59:40 INFO - PROCESS | 7061 | 06:59:42 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:59:43 INFO - PROCESS | 7061 | RSS: Main: 157667328 06:59:43 INFO - PROCESS | 7061 | 06:59:45 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:59:46 INFO - PROCESS | 7061 | RSS: Main: 158388224 06:59:46 INFO - PROCESS | 7061 | 06:59:49 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:49 INFO - PROCESS | 7061 | RSS: Main: 158351360 06:59:49 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | Cycle 1(1): loaded http://localhost:48213/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48213/tests/kraken/driver.html?testName=ai-astar) 06:59:51 INFO - PROCESS | 7061 | RSS: Main: 159895552 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | __start_tp_report 06:59:51 INFO - PROCESS | 7061 | _x_x_mozilla_page_load 06:59:51 INFO - PROCESS | 7061 | _x_x_mozilla_page_load_details 06:59:51 INFO - PROCESS | 7061 | |i|pagename|runs| 06:59:51 INFO - PROCESS | 7061 | |0;ai-astar;110;107;111;110;112;123;113;111;111;110 06:59:51 INFO - PROCESS | 7061 | |1;audio-beat-detection;146;125;163;177;125;159;152;127;192;128 06:59:51 INFO - PROCESS | 7061 | |2;audio-dft;163;167;166;163;161;161;162;162;165;162 06:59:51 INFO - PROCESS | 7061 | |3;audio-fft;75;76;76;182;73;76;77;76;162;77 06:59:51 INFO - PROCESS | 7061 | |4;audio-oscillator;92;92;148;91;92;93;151;92;99;146 06:59:51 INFO - PROCESS | 7061 | |5;imaging-gaussian-blur;118;118;118;117;117;118;118;117;117;117 06:59:51 INFO - PROCESS | 7061 | |6;imaging-darkroom;146;147;146;146;146;146;146;148;146;146 06:59:51 INFO - PROCESS | 7061 | |7;imaging-desaturate;95;94;96;97;95;96;94;95;96;95 06:59:51 INFO - PROCESS | 7061 | |8;json-parse-financial;57;57;58;56;56;55;61;84;56;53 06:59:51 INFO - PROCESS | 7061 | |9;json-stringify-tinderbox;56;57;57;57;58;57;58;57;56;57 06:59:51 INFO - PROCESS | 7061 | |10;stanford-crypto-aes;73;76;80;73;73;76;75;81;73;74 06:59:51 INFO - PROCESS | 7061 | |11;stanford-crypto-ccm;126;122;124;124;118;124;121;121;149;118 06:59:51 INFO - PROCESS | 7061 | |12;stanford-crypto-pbkdf2;165;163;162;159;161;157;157;160;164;155 06:59:51 INFO - PROCESS | 7061 | |13;stanford-crypto-sha256-iterative;66;68;69;69;69;65;72;66;66;67 06:59:51 INFO - PROCESS | 7061 | __end_tp_report 06:59:51 INFO - PROCESS | 7061 | __start_cc_report 06:59:51 INFO - PROCESS | 7061 | _x_x_mozilla_cycle_collect,873 06:59:51 INFO - PROCESS | 7061 | __end_cc_report 06:59:51 INFO - PROCESS | 7061 | __startTimestamp1462283991642__endTimestamp 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | ------- Summary: start ------- 06:59:51 INFO - PROCESS | 7061 | Number of tests: 14 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.24 (3.8%) stddev-sans-first:4.44 06:59:51 INFO - PROCESS | 7061 | Values: 110.0 107.0 111.0 110.0 112.0 123.0 113.0 111.0 111.0 110.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.50 stddev:23.62 (15.2%) stddev-sans-first:25.02 06:59:51 INFO - PROCESS | 7061 | Values: 146.0 125.0 163.0 177.0 125.0 159.0 152.0 127.0 192.0 128.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 06:59:51 INFO - PROCESS | 7061 | Values: 163.0 167.0 166.0 163.0 161.0 161.0 162.0 162.0 165.0 162.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:40.87 (53.8%) stddev-sans-first:42.70 06:59:51 INFO - PROCESS | 7061 | Values: 75.0 76.0 76.0 182.0 73.0 76.0 77.0 76.0 162.0 77.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:26.85 (29.2%) stddev-sans-first:27.71 06:59:51 INFO - PROCESS | 7061 | Values: 92.0 92.0 148.0 91.0 92.0 93.0 151.0 92.0 99.0 146.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:59:51 INFO - PROCESS | 7061 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:59:51 INFO - PROCESS | 7061 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 148.0 146.0 146.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 06:59:51 INFO - PROCESS | 7061 | Values: 95.0 94.0 96.0 97.0 95.0 96.0 94.0 95.0 96.0 95.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.00 stddev:8.92 (15.6%) stddev-sans-first:9.42 06:59:51 INFO - PROCESS | 7061 | Values: 57.0 57.0 58.0 56.0 56.0 55.0 61.0 84.0 56.0 53.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.60 06:59:51 INFO - PROCESS | 7061 | Values: 56.0 57.0 57.0 57.0 58.0 57.0 58.0 57.0 56.0 57.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:2.95 (3.9%) stddev-sans-first:3.00 06:59:51 INFO - PROCESS | 7061 | Values: 73.0 76.0 80.0 73.0 73.0 76.0 75.0 81.0 73.0 74.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.00 stddev:8.93 (7.2%) stddev-sans-first:9.46 06:59:51 INFO - PROCESS | 7061 | Values: 126.0 122.0 124.0 124.0 118.0 124.0 121.0 121.0 149.0 118.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.50 stddev:3.30 (2.0%) stddev-sans-first:3.03 06:59:51 INFO - PROCESS | 7061 | Values: 165.0 163.0 162.0 159.0 161.0 157.0 157.0 160.0 164.0 155.0 06:59:51 INFO - PROCESS | 7061 | 06:59:51 INFO - PROCESS | 7061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:2.11 (3.1%) stddev-sans-first:2.15 06:59:51 INFO - PROCESS | 7061 | Values: 66.0 68.0 69.0 69.0 69.0 65.0 72.0 66.0 66.0 67.0 06:59:51 INFO - PROCESS | 7061 | -------- Summary: end -------- 06:59:51 INFO - PROCESS | 7061 | 06:59:52 INFO - TEST-INFO | 7061: exit 0 06:59:52 INFO - TEST-OK | kraken | took 60806ms 06:59:52 INFO - SUITE-END | took 1169s 06:59:52 INFO - Completed test suite (00:19:30) 06:59:52 INFO - javascript benchmark 06:59:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.410003249431, 3464.8267586620664, 3481.2689335239593, 3485.424904890693, 3514.2971405718863, 5654.264945557082, 5678.233438485809, 5704.429557044294, 5719.485246327829, 5722.370539240691, 5684.37471878093, 5689.459501347375, 5726.7422965966525, 5731.570132240078, 5757.740901659425, 5067.7212753298645, 5146.40816306124, 5199.324087868572, 5224.843254702365, 5234.816781412651, 5104.489551044884, 5187.766550505236, 5251.894962100756, 5273.973630131844, 5311.521963023327, 5131.615128865331, 5156.948430515685, 5171.87070323243, 5177.171652535595, 5187.662801917863, 5094.92357614638, 5142.254373115896, 5152.9484705152845, 5176.327077479941, 5188.92216616751, 4969.751512424365, 5062.1141300272675, 5066.594672426234, 5083.034223497523, 5093.974530127362, 5392.137258038695, 5419.945800541984, 5453.318335208099, 5455.099908515091, 5464.972675136639, 6007.549433792483, 6017.608855424427, 6020.819375418744, 6032.27612686476, 6035.0, 5994.880102397971, 6022.909656355158, 6107.664078475682, 6133.417325354084, 6162.568620196588, 5761.567882408836, 5767.279090113736, 5773.971130144322, 5775.3935836736955, 5779.595428320019, 6200.875982480326, 6302.936970630327, 6303.558750887394, 6311.084892690534, 6313.273973493107, 5957.880842383128, 5983.640981541122, 6029.487493563096, 6049.18336024631, 6077.665728384893, 6082.847928801815, 6092.72582733778, 6120.17377654011, 6125.938740612626, 6130.877382452415, 5928.851778705481, 6089.0, 6104.175936248638, 6117.785877494266, 6120.7551697931585, 5931.436513531207, 5982.4017598239825, 5985.670788106609, 5995.280566332068, 6021.638701677914, 4524.7511386873375, 4580.610648094883, 4584.6561507887045, 4597.678162528591, 4603.723776573416, 4067.5322337930925, 4078.0416602098485, 4098.467199264077, 4112.424260603518, 4163.708540402143, 5784.508316793035, 5849.970750146307, 5944.494717949023, 5960.135780311917, 6031.336552979256, 5913.940860591425, 5943.286805583271, 5962.105684147413, 5977.222961015127, 5986.610870293417, 5717.742701578439, 5766.365699773021, 5784.161296612052, 5785.0, 5865.35481097079, 5130.358705161855, 5133.8716532087, 5143.099957507496, 5174.844754657366, 5181.81863634771, 6380.585261957958, 6398.104265402847, 6410.8076757697345, 6411.711472983727, 6415.166028416276, 5957.165996760544, 6116.969415152985, 6121.540884433596, 6135.447809697149, 6159.630422174684, 6187.783427580013, 6195.566310358232, 6199.752009919553, 6210.720517576629, 6230.314665386894, 5840.503557197516, 5858.121281807763, 5870.090136028923, 5888.440598143169, 5895.469407753323, 5914.497267732291, 5959.523238141025, 6060.878782424239, 6116.457510225511, 6150.384961503813, 5996.130561068708, 6003.099535069775, 6024.668643224665, 6028.186194863637, 6029.728662210124, 5894.823155305347, 5935.139404786196, 5964.224650795369, 5972.8805423892145, 5982.46157845796, 5808.39011903744, 5876.0, 5927.081302398135, 5944.762209511744, 5983.7008149591475, 5990.4908082813445, 5994.730237139426, 6006.339302676614, 6010.398960104129, 6037.15479832815, 5645.576581756302, 5898.498627616701, 5899.46904778572, 5900.055991041413, 5907.40925907423], "value": 5603.180332267492, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3557142714639, 674.0058413839586, 683.1255992329814, 683.5830143612397, 744.9830980711331, 33664.326713465714, 40262.0, 40994.180116397656, 41122.38316425248, 41381.13784879684, 43987.0, 44762.77618611902, 44922.77538612302, 45050.774746126306, 45122.774386128025, 8744.825103497926, 8973.95513022434, 8980.057094005133, 9013.864792028126, 9033.683821066264, 8660.437071590326, 8770.254528365096, 8776.780580485507, 8828.779280518007, 8944.150305720947, 8831.911680883206, 8909.95545022274, 8916.108389161096, 8917.73246802597, 8942.329325300596, 8966.730998070036, 8993.55032248385, 9038.954805225965, 9042.999999999967, 9061.0, 9030.86453703195, 9101.226395756368, 9128.269738420977, 9185.081491850828, 9199.54002299889, 45050.09899801986, 45553.772231138966, 45687.771561141984, 45819.77090114528, 45844.0, 3836.712246581518, 3948.6248806363637, 3984.6812255019527, 4001.7598944063448, 4563.06457176278, 33165.0, 34178.0, 34487.6551234487, 34702.6529734702, 35600.643993560254, 4424.867253982386, 4523.208438523246, 4523.532181714514, 4541.386912766768, 4572.51988541205, 329078.0, 330866.0, 331676.0, 333360.0, 333956.99999999756, 62138.68930655408, 62165.06752398718, 62390.376096238455, 62437.375626243156, 62447.0, 61082.38917610767, 62023.37976620176, 62431.37568624347, 62770.37229627737, 65014.67492662601, 18297.268109275745, 18692.7196092056, 18702.906485467487, 18719.157637906326, 18756.53108672267, 14344.49794257196, 14434.206118663575, 14442.927785361006, 14454.1327520347, 14474.348654310581, 20678.276260330815, 20832.1667133313, 20896.268630597857, 20977.0, 21069.578608427746, 7928.841423171504, 8178.877316840252, 8192.425344506328, 8201.95899020501, 8371.58142092893, 1139.3179005134825, 1149.2759561476216, 1157.8147496400704, 1175.7178277213407, 1199.6161228406827, 33194.170145746066, 33235.33529329448, 33297.50053749196, 33588.328233435685, 33898.32203355919, 1180.2741314091943, 1187.4597058338436, 1189.3874654552912, 1220.9389530523438, 1234.234774439853, 17819.287228510715, 17862.19620117098, 17893.910530447265, 18045.368412105778, 18324.541886452946, 310920.0, 320302.0, 323754.0, 325811.0, 496220.0, 62371.688141559, 63269.0, 63493.047604285974, 63496.36503634997, 64082.35917640857, 1494.521753039017, 1499.078066988794, 1500.752375857993, 1509.0870023635543, 1512.296781996377, 32464.188395290308, 32705.0, 33176.83411582927, 33231.0, 33917.66082339145, 53786.19320710114, 54184.0, 54298.45701543092, 54635.726821365635, 54663.72668136634, 374345.0, 375027.0, 375410.0, 375780.0, 377320.0, 30613.0, 31010.0, 42441.787791060844, 43339.13321733611, 43398.56601433945, 44964.77517612391, 46703.29945050759, 46704.29943550781, 46706.76646616745, 47401.52598473971, 40884.79557602312, 41869.162616746886, 42612.14775704406, 42739.78630106829, 43091.0, 40500.3924941132, 40902.59097408988, 40924.79537602412, 41449.585504145776, 42219.36670949877, 40874.59125408708, 41455.0, 41937.0, 42009.0, 42033.57966420419, 36350.27299454049, 36352.462088090964, 36557.0, 36722.816385918966, 37182.256354873294, 27435.765390557073, 28131.296717582223, 28951.796940930803, 28973.696183671364, 29535.55696664595], "value": 20862.41460278254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.63695677152793, 433.64224514775316, 434.5220257716511, 436.9322754972976, 438.11500768447735, 18807.247710091597, 18847.246110155593, 19502.317418890343, 19536.70694939577, 19566.90216548917, 18475.35336263231, 18573.53566160847, 18675.0, 18858.0, 19401.708974365396, 5649.519790817775, 6085.695715214244, 6094.451499365056, 6099.359567245419, 6104.359042300561, 5844.561657875655, 5911.379305172959, 6044.455998960093, 6052.303985041711, 6060.030395136779, 5986.8802623947495, 5993.550483713717, 6013.338532761392, 6019.1874096997, 6031.095335699636, 5722.427757224306, 5893.911591326134, 5930.792422265243, 5967.283925928895, 5982.491488223506, 5268.130758424893, 5303.257543943851, 5309.840704778863, 5320.388155362106, 5345.091334473149, 23365.766342336698, 23932.401689957715, 24463.63304550433, 24501.877490612434, 24610.630840537407, 2552.527782360269, 2571.2543362424876, 2599.974000259992, 2762.2127693607426, 2769.9751092096053, 14306.141631502143, 14973.176475293854, 15399.384024639001, 15436.228188590525, 15782.921085394615, 2045.427280361501, 2066.617675729995, 2101.159536185523, 2138.8395870309787, 2210.071769856664, 61608.4597885052, 81752.0, 82625.58687206586, 83575.0, 88071.55964220202, 10635.52140153695, 11362.659120226406, 11373.431328433711, 11970.22193557416, 12442.37788110591, 17026.574335641708, 17039.48881533556, 17114.828851711325, 17154.742678859828, 17183.484495464905, 9187.862182067274, 9265.2124569411, 9279.39683920543, 9331.0, 9345.0, 8908.73273801787, 8976.102389761103, 9066.365354425126, 9067.773305667411, 9095.590698418588, 5016.673916195508, 5140.0, 5172.948270517322, 5228.790848366023, 5272.446393128666, 2092.571022940324, 2101.642720737478, 2114.186038375206, 2153.8169255613448, 2205.8455908086603, 1078.0243879289255, 1080.1952545353604, 1105.3202280597375, 1158.959436419738, 1178.8762179971152, 17795.0, 19596.314129005415, 19854.60290794176, 20351.69472457914, 20907.895460522905, 1070.817960946641, 1071.5124618298655, 1085.267444474992, 1133.4219548030399, 1142.5715356741223, 11208.15938804593, 11270.605528806453, 11341.319520828776, 11412.258203216765, 11543.71140721472, 558031.0, 571816.0, 582445.0, 593892.0, 604192.0, 81624.0, 99844.0, 103681.0, 104509.0, 105664.47167764112, 1073.6939972108069, 1112.4826955465746, 1120.7198200449889, 1127.22784892349, 1128.5993472317373, 16891.32434702598, 17155.828441715923, 17249.56876078108, 17299.30802767875, 17432.30270789205, 41684.58315416807, 41948.580514194466, 43261.567384325754, 45456.772716136205, 46611.53388466072, 56718.0, 58196.4180358191, 59211.0, 63409.0, 64760.0, 13261.734765304447, 13522.0, 13586.79619805684, 13625.86374136246, 13886.444542218198, 14684.118952862862, 15094.094354338775, 15137.924310378377, 15266.770998435255, 15550.844491554939, 12841.743165136832, 12861.164024338388, 12979.41592628315, 13069.085164038426, 13891.235982020682, 8592.140785921358, 8943.597538110671, 9004.189622933967, 9026.954865225633, 12440.377981100728, 8979.416337938013, 8994.010658827654, 9020.188183063556, 9098.499582523025, 9147.725568232963, 13272.46910123623, 13491.190528568317, 13494.055416120776, 13548.86451135476, 13562.254076025913, 12764.936175319064, 13171.341432928506, 13228.801567976681, 13254.337283135612, 13295.069345145746], "value": 10018.184631991971, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.1684324151443, 1643.6959162554929, 1874.737536744856, 1904.400113964102, 1969.1335812242603, 7792.181820908808, 8573.699920502784, 8625.22372986431, 8892.021877593468, 8944.195022447979, 8580.0, 8644.783880402993, 8699.95650021749, 8716.302695784338, 8748.475091494514, 2266.841321107519, 2272.8977196026217, 2286.554121946221, 2294.3575798776287, 2297.2993237062688, 2375.643653451979, 2378.916737914173, 2430.2952143878256, 2446.107170882624, 2454.5949918263555, 2331.650252462136, 2354.8469349492316, 2372.217168334454, 2409.277216834951, 2412.9155479558217, 2371.1819422299277, 2376.287113865842, 2378.15575470708, 2384.43965668067, 2405.9398515037087, 2264.615015447378, 2282.3038973113194, 2313.2828823064906, 2321.7330007049068, 2324.1052194905083, 8995.415298005608, 9031.819363612756, 9048.457092574467, 9085.77285567866, 9087.863682044775, 5185.170372740344, 5318.202269659543, 5342.439043900374, 5374.677519348852, 5376.865578360533, 3332.6167490738635, 3333.799972001688, 3398.575178102737, 3431.9656803431894, 3469.3581687387664, 1127.4362818590705, 1131.9830202546968, 1151.8732939376662, 1192.3322939154102, 1195.1394995603152, 12320.137590368679, 12350.25898446105, 12393.194442361308, 12435.44040518179, 12448.62654120378, 4707.693999889996, 4778.665493415428, 4804.124323415052, 4844.709317440965, 4956.727379994063, 10344.32761870476, 10392.844107338396, 10396.324238924446, 10402.5838966442, 10406.791864162826, 5403.243545903577, 5436.130219164915, 5464.617476776588, 5478.205660179252, 5509.807156749494, 4334.544872788375, 4946.208606622995, 4969.229769385751, 5141.177411614124, 5152.974235128875, 4273.358996150602, 4301.41930839339, 4309.741415515079, 4368.8907777305185, 4373.868783936487, 1394.219237227156, 1402.193738600309, 1410.104583589428, 1410.4428750643438, 1429.535400994681, 880.8942926848691, 936.9063093690577, 1055.4195192644015, 1063.2450959818461, 1074.3768614203743, 5961.761529538857, 6018.337982821886, 6053.818385448443, 6070.605410648293, 6169.0, 438.6052552702593, 452.030394803152, 456.5320546439926, 459.8367579509226, 461.59379745824134, 4333.566643335641, 4354.628292087982, 4386.495553011381, 4390.165868484977, 4394.209042372339, 10844.13246940243, 11358.886411135949, 11400.144989125849, 11402.429878506042, 11412.543498260142, 11107.38909359993, 11160.944195278971, 11168.66494005181, 11238.100951923827, 11252.0, 7935.285824275843, 8317.667293308321, 8318.875216871631, 8330.541820199947, 8475.49147051179, 5911.142884281841, 6108.8778224436155, 6124.0, 6240.875182496234, 6276.905846412216, 9988.750281242736, 10212.387256764618, 10390.116840068678, 10440.060394564525, 10556.208284378548, 10397.53211105487, 10573.259871809207, 10591.0, 10622.415767132881, 10642.308249963728, 7769.922300777146, 8397.160283971554, 8402.663893444194, 8518.61666225009, 8613.956930215309, 8665.956670216608, 8710.564471776512, 8766.474011559327, 8810.691625793066, 8812.250958668328, 7721.7683469496005, 8070.803182345265, 8234.547099909563, 8245.752627420947, 8319.459235149696, 7837.6081195941115, 8111.675532978615, 8114.797130071795, 8123.83752324962, 8166.142555031636, 7433.331000210007, 7488.775336739906, 7515.436342274461, 7532.7740167795055, 7578.43161762881, 5333.386660533933, 5347.064263753905, 5482.0, 5524.530414914777, 5585.720713964367, 5215.139501982282, 5242.711650859087, 5338.519533242027, 5418.160185171305, 5447.182922561489], "value": 4704.6883365485855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2229095988825, 357.3264396612385, 362.5794078868513, 364.6317219608195, 366.12313509145616, 5688.345840228375, 5789.481575514654, 5817.796377126801, 5826.592138550303, 5864.618799778012, 5603.103503439451, 5717.685527295997, 5736.655800651964, 5742.310922689273, 5743.5118014968775, 4418.238600874453, 4421.513633500304, 4432.15789000089, 4432.867013989586, 4454.354118652794, 4429.46846378435, 4436.511983681792, 4446.933296000562, 4448.266036104039, 4451.62161216297, 4397.824087036531, 4414.889627759316, 4423.601875831175, 4429.55704429556, 4443.488998765135, 4326.221280169569, 4382.715123516993, 4390.40729501518, 4396.692231543793, 4424.40270563473, 3878.825452854628, 3880.4955355803845, 3894.143288476559, 3903.4730311408166, 3908.0, 5498.862528436781, 5514.558835293167, 5517.172424136412, 5546.889062218774, 5548.446434998207, 4993.850184494471, 5066.797328106872, 5091.287219789232, 5091.592672586185, 5119.59043276537, 5981.910271345933, 5995.040793473024, 5999.89002034625, 6007.399260074001, 6030.909536356959, 4327.156204540116, 4337.63130133939, 4344.435223420966, 4354.608085272309, 4373.497047839507, 5927.673977931212, 6078.756849726005, 6230.470410015154, 6257.5619706620555, 6269.843253918643, 4295.806688699016, 4308.849190278325, 4313.525512193656, 4339.1972485090355, 4344.500382456058, 4377.956220437819, 4379.693421460467, 4383.758893260838, 4391.626711729538, 4397.8240870364825, 4944.579710724557, 4958.925466210972, 5019.820342219576, 5035.640377098163, 5054.241863720398, 5957.463828255478, 5968.46283834457, 5984.1921340618455, 6017.939820601826, 6027.969860150672, 1571.1515781477874, 1572.4889410941262, 1573.7245981953342, 1578.2345562402227, 1582.9920850395674, 1064.5156453813497, 1091.3997301484153, 1093.8632670916136, 1096.6490722968733, 1096.961606343774, 6208.317085120633, 6236.345183755731, 6245.313015568284, 6285.9057114143325, 6304.211973503312, 6545.800769627397, 6552.475801935833, 6586.85927073703, 6593.571417857824, 6617.933820661828, 6137.5703700741415, 6237.157983672146, 6248.593841400295, 6264.749410023639, 6296.212973378328, 3504.0, 3538.327717733622, 3547.769394989369, 3548.822558872046, 3562.750607457453, 6761.560498567577, 6777.542828291941, 6904.723811047602, 6910.412614927787, 6918.654067296615, 6747.865042699119, 6772.627505487147, 6783.998720377501, 6785.830354241085, 6799.286074962157, 6734.629595372302, 6834.3687680243465, 6845.349691779273, 6856.897146542806, 6955.408790252784, 6590.275069742229, 6610.2398224204835, 6622.1722284714415, 6639.568428052161, 6656.7670131545165, 6345.524085693499, 6504.284528701934, 6513.54405191632, 6545.574537655038, 6584.407403333723, 6311.558190926591, 6450.29067297176, 6472.546921715623, 6483.902741458976, 6527.15147030883, 4437.622802061861, 4554.499005109502, 4563.680542362003, 4576.382188404523, 4592.7014744041535, 6154.9384506154365, 6223.813285601439, 6249.312575616587, 6270.905936410866, 6289.874202516015, 5979.1928089707335, 5986.790462333797, 6042.456178943916, 6083.878322433615, 6107.6640784757265, 5863.824085277449, 6022.247219097613, 6059.8790423351475, 6078.7872424466705, 6081.817545473643, 5943.910841337297, 5946.910796338145, 5952.672603006876, 5978.461938425563, 5979.730912109053, 6003.579749417673, 6106.511479081574, 6117.449429551361, 6117.785877494266, 6125.540584456273, 5750.25246717924, 5854.326752423526, 5872.794452194153, 5874.706264686834, 5904.9075920954765], "value": 4682.523882154358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9244821741936, 812.1878121878121, 820.0, 825.0923983618019, 829.1294141151797, 13774.44902203913, 14177.929110354435, 14389.2805359732, 14515.56453306401, 14581.270936453175, 13893.0, 13958.51145209918, 14111.0, 14127.92936035321, 14151.0, 887.5872719185561, 923.5336155241594, 924.1636319131163, 928.1878356438117, 933.6685476655791, 920.2132176988679, 924.1867156901917, 928.5867788833938, 929.8744669469636, 930.9813803723921, 965.5413678502725, 967.666155176463, 972.5283237629744, 975.1370037516813, 978.5107446276861, 966.1304825656965, 967.2552134856121, 968.4334664221439, 968.5883499512679, 970.8009857979133, 709.992900071003, 711.121764620693, 711.9323664251888, 713.2617740638466, 718.396546900606, 15968.600784980352, 15997.120158391284, 16029.759553606706, 16074.839251607451, 16110.11394373309, 13969.0, 14018.228997405138, 14519.854801451957, 14704.926475367554, 14837.0, 11649.650510484698, 11747.29516229029, 11839.704007399798, 11980.70048248792, 12171.93914030433, 3839.4432807242792, 3929.7445666031617, 3964.444977703095, 3967.3255546557157, 4019.638232559084, 56088.43911560873, 56624.0, 56714.0, 57385.13922291169, 60058.09912851311, 11464.140189485823, 11504.76990460186, 11741.354225517507, 11813.291202527877, 12006.759864802654, 19408.611827763365, 19438.4168474946, 19670.31153909635, 19791.30730424428, 19950.20199192045, 8632.136786321318, 8718.258947989365, 8728.563571821383, 8741.737747867573, 9091.590878410487, 4967.130752118364, 5027.748612569357, 5099.56653684441, 5141.074606570854, 5154.0, 3634.9636503635156, 3645.854165833337, 3834.731568790158, 3852.8266228019247, 3860.749051311656, 721.6788529104498, 726.1068885271146, 732.3701616609818, 736.8194792275926, 740.7333359990399, 622.7508996401476, 646.5506473001219, 653.6568301641581, 714.2857142857143, 714.5212707485997, 8878.86681699775, 8927.571588545932, 8987.865182022275, 8999.100089990949, 9243.76890577741, 709.2092317066433, 732.974345897891, 747.8354761952362, 767.3784234769743, 772.4129661457333, 4320.157569273962, 4388.078503514298, 4406.537313582027, 4433.977830110829, 4506.774661266923, 61000.0, 61308.38691613116, 61982.140535784, 62235.37764622296, 64403.0, 61885.0, 63193.684031580466, 63374.0, 63485.0, 63640.68179659165, 54838.72580637151, 55407.722961384934, 56624.43375566274, 56899.14651280234, 59934.400655993755, 9092.221674557884, 9419.480881942594, 9568.712938611852, 9618.615255389706, 9637.325387222827, 33381.33237335288, 34217.0, 34728.13179670528, 34792.47811282782, 34874.30251395009, 45473.31790023086, 49002.0, 49029.0, 49440.25839612481, 49743.25385119153, 12232.694182645506, 12873.549425770054, 13115.672108197372, 13179.868201318248, 13329.200247985153, 12879.484820607071, 13395.866041339852, 13606.25165615861, 13620.38708258111, 15442.691146176789, 13121.934390327988, 13614.455421783414, 13736.244506552235, 14482.565523034325, 14501.129932204101, 13076.476940922637, 13729.970252230924, 13748.243846588533, 13933.094348867291, 13978.231197284247, 12109.273443593413, 12349.876501234872, 12765.61703148907, 12801.29592872401, 13016.674583135497, 10861.837072443761, 10869.402182880018, 11246.381449020382, 11520.53917843277, 11601.941990290332, 10387.0, 11188.496517656888, 11374.374409407563, 11519.654410367702, 11546.538138474367], "value": 7168.4277771928955, "unit": "score"}], "name": "dromaeo_css", "value": 7548.213546300054, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 111.0, 110.0, 112.0, 123.0, 113.0, 111.0, 111.0, 110.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 163.0, 177.0, 125.0, 159.0, 152.0, 127.0, 192.0, 128.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 166.0, 163.0, 161.0, 161.0, 162.0, 162.0, 165.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 182.0, 73.0, 76.0, 77.0, 76.0, 162.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 91.0, 92.0, 93.0, 151.0, 92.0, 99.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 97.0, 95.0, 96.0, 94.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 56.0, 56.0, 55.0, 61.0, 84.0, 56.0, 53.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 58.0, 57.0, 58.0, 57.0, 56.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 80.0, 73.0, 73.0, 76.0, 75.0, 81.0, 73.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 124.0, 124.0, 118.0, 124.0, 121.0, 121.0, 149.0, 118.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 159.0, 161.0, 157.0, 157.0, 160.0, 164.0, 155.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 69.0, 69.0, 65.0, 72.0, 66.0, 66.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1532.5, "alertThreshold": 2.0}]} 06:59:52 INFO - Return code: 0 06:59:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:59:52 ERROR - # TBPL SUCCESS # 06:59:52 INFO - Running post-action listener: _resource_record_post_action 06:59:52 INFO - Running post-run listener: _resource_record_post_run 06:59:54 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 274432; Write bytes: 322777088; Read time: 460; Write time: 218712 06:59:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 76828672; Read time: 280; Write time: 78272 06:59:54 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 270336; Write bytes: 245948416; Read time: 180; Write time: 140440 06:59:54 INFO - Running post-run listener: _upload_blobber_files 06:59:54 INFO - Blob upload gear active. 06:59:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59:54 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 06:59:54 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'] 06:59:54 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 06:59:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:55 INFO - (blobuploader) - INFO - Done attempting. 06:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:56 INFO - (blobuploader) - INFO - Done attempting. 06:59:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:59:56 INFO - Return code: 0 06:59:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:59:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:59:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718d6c14432c3f613e1a534916fbefddda2b4e180e1ce3162edf843a64c82fe0b0d5870c22175f1345ab524947b00584bde5429956f4d920dc59a593ddd27378", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90671e9e368b7d4a89acc887da395960c00068d509c399672329c762f6fe464ab5bb521cdc29306bf728b9a5b3361fddc656e4040a78e2d3434a5eae105fff99"} 06:59:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:59:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:59:56 INFO - Contents: 06:59:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718d6c14432c3f613e1a534916fbefddda2b4e180e1ce3162edf843a64c82fe0b0d5870c22175f1345ab524947b00584bde5429956f4d920dc59a593ddd27378", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90671e9e368b7d4a89acc887da395960c00068d509c399672329c762f6fe464ab5bb521cdc29306bf728b9a5b3361fddc656e4040a78e2d3434a5eae105fff99"} 06:59:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:59:56 INFO - Copying logs to upload dir... 06:59:56 INFO - mkdir: /builds/slave/test/build/upload/logs 06:59:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2125.944817 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 25 secs) (at 2016-05-03 06:59:56.000752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 06:59:56.004517) ========= 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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718d6c14432c3f613e1a534916fbefddda2b4e180e1ce3162edf843a64c82fe0b0d5870c22175f1345ab524947b00584bde5429956f4d920dc59a593ddd27378", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90671e9e368b7d4a89acc887da395960c00068d509c399672329c762f6fe464ab5bb521cdc29306bf728b9a5b3361fddc656e4040a78e2d3434a5eae105fff99"} build_url:https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/ZRg1FZJLTOeR4APj1S1USw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/718d6c14432c3f613e1a534916fbefddda2b4e180e1ce3162edf843a64c82fe0b0d5870c22175f1345ab524947b00584bde5429956f4d920dc59a593ddd27378", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/90671e9e368b7d4a89acc887da395960c00068d509c399672329c762f6fe464ab5bb521cdc29306bf728b9a5b3361fddc656e4040a78e2d3434a5eae105fff99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 06:59:56.030915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:59:56.031378) ========= 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=db0483c52d987ecb441a263b000001ad-1462281868.452869-162507091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 06:59:56.114437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 06:59:56.114820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 06:59:56.115131) ========= ========= Total master_lag: 0.18 =========