builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1473590157.8 results: success (0) buildid: 20160911004011 builduid: a215e513ab524819816f7fde56c95a64 revision: 8663d41e015f3c9933a08a65c8349b86f2263354 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:57.797715) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:57.799041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:57.799841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:57.815710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:57.816309) ========= 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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-11 03:35:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-09-11 03:35:58 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:58.013080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:58.013442) ========= 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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016243 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:58.064532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 03:35:58.064973) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8663d41e015f3c9933a08a65c8349b86f2263354 --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 8663d41e015f3c9933a08a65c8349b86f2263354 --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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-11 03:35:58,856 truncating revision to first 12 chars 2016-09-11 03:35:58,856 Setting DEBUG logging. 2016-09-11 03:35:58,856 attempt 1/10 2016-09-11 03:35:58,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8663d41e015f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-11 03:36:00,297 unpacking tar archive at: mozilla-aurora-8663d41e015f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.870276 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 03:35:59.950410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:59.950879) ========= script_repo_revision: 8663d41e015f3c9933a08a65c8349b86f2263354 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:59.951339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:59.951679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 03:35:59.962037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 32 secs) (at 2016-09-11 03:35:59.962398) ========= /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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:00 INFO - MultiFileLogger online at 20160911 03:36:00 in /builds/slave/test 03:36:00 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 03:36:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:00 INFO - {'append_to_log': False, 03:36:00 INFO - 'base_work_dir': '/builds/slave/test', 03:36:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:36:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:00 INFO - 'branch': 'Mozilla-Aurora', 03:36:00 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:00 INFO - 'config_files': ('talos/linux_config.py',), 03:36:00 INFO - 'default_actions': ('clobber', 03:36:00 INFO - 'read-buildbot-config', 03:36:00 INFO - 'download-and-extract', 03:36:00 INFO - 'populate-webroot', 03:36:00 INFO - 'create-virtualenv', 03:36:00 INFO - 'install', 03:36:00 INFO - 'run-tests'), 03:36:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:00 INFO - 'download_minidump_stackwalk': True, 03:36:00 INFO - 'download_symbols': 'ondemand', 03:36:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:00 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:00 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:00 INFO - 'installer_path': 'installer.exe', 03:36:00 INFO - 'log_level': 'info', 03:36:00 INFO - 'log_name': 'talos', 03:36:00 INFO - 'log_to_console': True, 03:36:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:00 INFO - 'opt_config_files': (), 03:36:00 INFO - 'pip_index': False, 03:36:00 INFO - 'sps_profile': False, 03:36:00 INFO - 'sps_profile_interval': 0, 03:36:00 INFO - 'suite': 'dromaeojs-e10s', 03:36:00 INFO - 'system_bits': '32', 03:36:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:00 INFO - 'title': 'talos-linux64-ix-053', 03:36:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:00 INFO - 'use_talos_json': True, 03:36:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:00 INFO - 'work_dir': 'build'} 03:36:00 INFO - [mozharness: 2016-09-11 10:36:00.842171Z] Running clobber step. 03:36:00 INFO - Running pre-action listener: _resource_record_pre_action 03:36:00 INFO - Running main action method: clobber 03:36:00 INFO - rmtree: /builds/slave/test/build 03:36:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:01 INFO - Running post-action listener: _resource_record_post_action 03:36:01 INFO - [mozharness: 2016-09-11 10:36:01.298790Z] Finished clobber step (success) 03:36:01 INFO - [mozharness: 2016-09-11 10:36:01.298892Z] Running read-buildbot-config step. 03:36:01 INFO - Running pre-action listener: _resource_record_pre_action 03:36:01 INFO - Running main action method: read_buildbot_config 03:36:01 INFO - Using buildbot properties: 03:36:01 INFO - { 03:36:01 INFO - "project": "", 03:36:01 INFO - "product": "firefox", 03:36:01 INFO - "script_repo_revision": "production", 03:36:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:36:01 INFO - "repository": "", 03:36:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:36:01 INFO - "buildid": "20160911004011", 03:36:01 INFO - "stage_platform": "linux64-pgo", 03:36:01 INFO - "basedir": "/builds/slave/test", 03:36:01 INFO - "nightly_build": "True", 03:36:01 INFO - "buildnumber": 545, 03:36:01 INFO - "slavename": "talos-linux64-ix-053", 03:36:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:01 INFO - "platform": "ubuntu64_hw", 03:36:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:36:01 INFO - "branch": "mozilla-aurora", 03:36:01 INFO - "repo_path": "releases/mozilla-aurora", 03:36:01 INFO - "revision": "8663d41e015f3c9933a08a65c8349b86f2263354", 03:36:01 INFO - "pgo_build": "True", 03:36:01 INFO - "builduid": "a215e513ab524819816f7fde56c95a64", 03:36:01 INFO - "slavebuilddir": "test" 03:36:01 INFO - } 03:36:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:36:01 INFO - Running post-action listener: _resource_record_post_action 03:36:01 INFO - [mozharness: 2016-09-11 10:36:01.301404Z] Finished read-buildbot-config step (success) 03:36:01 INFO - [mozharness: 2016-09-11 10:36:01.301494Z] Running download-and-extract step. 03:36:01 INFO - Running pre-action listener: _resource_record_pre_action 03:36:01 INFO - Running main action method: download_and_extract 03:36:01 INFO - mkdir: /builds/slave/test/build/tests 03:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:01 INFO - https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:36:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:36:01 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:36:01 INFO - retry: Failed, sleeping 30 seconds before retrying 03:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:36:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:36:31 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:36:31 INFO - retry: Failed, sleeping 60 seconds before retrying 03:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:37:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:37:31 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:37:31 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:37:31 INFO - Caught exception: HTTP Error 404: Not Found 03:37:31 INFO - Caught exception: HTTP Error 404: Not Found 03:37:31 INFO - Caught exception: HTTP Error 404: Not Found 03:37:31 INFO - trying https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:37:31 INFO - Downloading https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:37:31 INFO - Downloaded 1361 bytes. 03:37:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:37:31 INFO - Using the following test package requirements: 03:37:31 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:31 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:31 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:31 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'jsshell-linux-x86_64.zip'], 03:37:31 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:31 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:31 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:31 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:31 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:31 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:31 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:31 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37: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')]} 03:37:31 INFO - https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:37:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:31 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:37:31 INFO - retry: Failed, sleeping 30 seconds before retrying 03:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:38:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:38:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:38:02 INFO - retry: Failed, sleeping 60 seconds before retrying 03:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:39:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:39:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:39:02 INFO - Caught exception: HTTP Error 404: Not Found 03:39:02 INFO - Caught exception: HTTP Error 404: Not Found 03:39:02 INFO - Caught exception: HTTP Error 404: Not Found 03:39:02 INFO - trying https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:02 INFO - Downloaded 21770552 bytes. 03:39:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:39:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:39:04 INFO - Return code: 0 03:39:04 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:04 INFO - https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:39:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:39:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:39:04 INFO - retry: Failed, sleeping 30 seconds before retrying 03:39:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:39:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:39:34 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:39:34 INFO - retry: Failed, sleeping 60 seconds before retrying 03:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:40:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:40:34 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:40:34 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:40:34 INFO - Caught exception: HTTP Error 404: Not Found 03:40:34 INFO - Caught exception: HTTP Error 404: Not Found 03:40:34 INFO - Caught exception: HTTP Error 404: Not Found 03:40:34 INFO - trying https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:40:34 INFO - Downloading https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:35 INFO - Downloaded 21770552 bytes. 03:40:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:40:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:40:36 INFO - Return code: 0 03:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:36 INFO - https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:40:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:40:36 INFO - retry: Failed, sleeping 30 seconds before retrying 03:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:41:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:41:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:41:06 INFO - retry: Failed, sleeping 60 seconds before retrying 03:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:42:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:42:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:42:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:42:06 INFO - Caught exception: HTTP Error 404: Not Found 03:42:06 INFO - Caught exception: HTTP Error 404: Not Found 03:42:06 INFO - Caught exception: HTTP Error 404: Not Found 03:42:06 INFO - trying https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:42:06 INFO - Downloading https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:42:07 INFO - Downloaded 14413740 bytes. 03:42:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:42:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:42:07 INFO - Return code: 0 03:42:07 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')]} 03:42:07 INFO - https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:42:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:42:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:42:07 INFO - retry: Failed, sleeping 30 seconds before retrying 03:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:42:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:42:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:42:37 INFO - retry: Failed, sleeping 60 seconds before retrying 03:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:43:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:43:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:43:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:43:37 INFO - Caught exception: HTTP Error 404: Not Found 03:43:37 INFO - Caught exception: HTTP Error 404: Not Found 03:43:37 INFO - Caught exception: HTTP Error 404: Not Found 03:43:37 INFO - trying https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:43:37 INFO - Downloading https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:43:38 INFO - Downloaded 63886264 bytes. 03:43:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:43:38 INFO - mkdir: /builds/slave/test/properties 03:43:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:38 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:38 INFO - Contents: 03:43:38 INFO - build_url:https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:43:39 INFO - Running post-action listener: _resource_record_post_action 03:43:39 INFO - Running post-action listener: set_extra_try_arguments 03:43:39 INFO - [mozharness: 2016-09-11 10:43:39.613173Z] Finished download-and-extract step (success) 03:43:39 INFO - [mozharness: 2016-09-11 10:43:39.613405Z] Running populate-webroot step. 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: populate_webroot 03:43:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:39 INFO - '--tppagecycles', 03:43:39 INFO - '7'], 03:43:39 INFO - 'tests': ['tsvgm']}}, 03:43:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['damp', 'tps']}, 03:43:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'tests': ['damp', 'tps']}, 03:43:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['dromaeo_dom']}, 03:43:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['basic_compositor_video']}, 03:43:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:43:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['a11yr', 03:43:39 INFO - 'ts_paint', 03:43:39 INFO - 'tpaint', 03:43:39 INFO - 'sessionrestore', 03:43:39 INFO - 'sessionrestore_no_auto_restore', 03:43:39 INFO - 'tabpaint']}, 03:43:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['tsvgx', 03:43:39 INFO - 'tsvgr_opacity', 03:43:39 INFO - 'tart', 03:43:39 INFO - 'tscrollx', 03:43:39 INFO - 'cart']}, 03:43:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:39 INFO - 'tsvgr_opacity', 03:43:39 INFO - 'tart', 03:43:39 INFO - 'tscrollx', 03:43:39 INFO - 'cart']}, 03:43:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'talos_options': ['--disable-e10s'], 03:43:39 INFO - 'tests': ['tp5o']}, 03:43:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'tests': ['tp5o']}, 03:43:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'talos_options': ['--disable-e10s', 03:43:39 INFO - '--xperf_path', 03:43:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:39 INFO - 'tests': ['tp5n']}, 03:43:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:43:39 INFO - 'talos_options': ['--xperf_path', 03:43:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:39 INFO - 'tests': ['tp5n']}}, 03:43:39 INFO - 'talos.zip': {'path': '', 03:43:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:39 INFO - Running post-action listener: _resource_record_post_action 03:43:39 INFO - [mozharness: 2016-09-11 10:43:39.632159Z] Finished populate-webroot step (success) 03:43:39 INFO - [mozharness: 2016-09-11 10:43:39.632247Z] Running create-virtualenv step. 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: create_virtualenv 03:43:39 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:39 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 03:43:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:43:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:39 INFO - Using real prefix '/usr' 03:43:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:40 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:42 INFO - Installing pip.................done. 03:43:42 INFO - Return code: 0 03:43:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:43:42 INFO - Using env: {'DISPLAY': ':0', 03:43:42 INFO - 'HOME': '/home/cltbld', 03:43:42 INFO - 'LANG': 'en_US.UTF-8', 03:43:42 INFO - 'LANGUAGE': 'en_US:en', 03:43:42 INFO - 'LOGNAME': 'cltbld', 03:43:42 INFO - 'MAIL': '/var/mail/cltbld', 03:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:42 INFO - 'MOZ_NO_REMOTE': '1', 03:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:42 INFO - 'NO_EM_RESTART': '1', 03:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:42 INFO - 'PWD': '/builds/slave/test', 03:43:42 INFO - 'SHELL': '/bin/bash', 03:43:42 INFO - 'SHLVL': '1', 03:43:42 INFO - 'TERM': 'linux', 03:43:42 INFO - 'TMOUT': '86400', 03:43:42 INFO - 'USER': 'cltbld', 03:43:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:42 INFO - '_': '/tools/buildbot/bin/python'} 03:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:42 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 03:43:42 INFO - Cleaning up... 03:43:42 INFO - Return code: 0 03:43:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:43:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:43:42 INFO - Using env: {'DISPLAY': ':0', 03:43:42 INFO - 'HOME': '/home/cltbld', 03:43:42 INFO - 'LANG': 'en_US.UTF-8', 03:43:42 INFO - 'LANGUAGE': 'en_US:en', 03:43:42 INFO - 'LOGNAME': 'cltbld', 03:43:42 INFO - 'MAIL': '/var/mail/cltbld', 03:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:42 INFO - 'MOZ_NO_REMOTE': '1', 03:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:42 INFO - 'NO_EM_RESTART': '1', 03:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:42 INFO - 'PWD': '/builds/slave/test', 03:43:42 INFO - 'SHELL': '/bin/bash', 03:43:42 INFO - 'SHLVL': '1', 03:43:42 INFO - 'TERM': 'linux', 03:43:42 INFO - 'TMOUT': '86400', 03:43:42 INFO - 'USER': 'cltbld', 03:43:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:42 INFO - '_': '/tools/buildbot/bin/python'} 03:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:42 INFO - Downloading/unpacking psutil>=3.1.1 03:43:42 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 03:43:42 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 03:43:42 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 03:43:42 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 03:43:42 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 03:43:42 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 03:43:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:44 INFO - Installing collected packages: psutil 03:43:44 INFO - Running setup.py install for psutil 03:43:44 INFO - building 'psutil._psutil_linux' extension 03:43:44 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 03:43:44 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 03:43:44 INFO - building 'psutil._psutil_posix' extension 03:43:44 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 03:43:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:43:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:45 INFO - Successfully installed psutil 03:43:45 INFO - Cleaning up... 03:43:45 INFO - Return code: 0 03:43:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:43:45 INFO - Using env: {'DISPLAY': ':0', 03:43:45 INFO - 'HOME': '/home/cltbld', 03:43:45 INFO - 'LANG': 'en_US.UTF-8', 03:43:45 INFO - 'LANGUAGE': 'en_US:en', 03:43:45 INFO - 'LOGNAME': 'cltbld', 03:43:45 INFO - 'MAIL': '/var/mail/cltbld', 03:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:45 INFO - 'MOZ_NO_REMOTE': '1', 03:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:45 INFO - 'NO_EM_RESTART': '1', 03:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:45 INFO - 'PWD': '/builds/slave/test', 03:43:45 INFO - 'SHELL': '/bin/bash', 03:43:45 INFO - 'SHLVL': '1', 03:43:45 INFO - 'TERM': 'linux', 03:43:45 INFO - 'TMOUT': '86400', 03:43:45 INFO - 'USER': 'cltbld', 03:43:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:45 INFO - '_': '/tools/buildbot/bin/python'} 03:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:47 INFO - Installing collected packages: mozsystemmonitor 03:43:47 INFO - Running setup.py install for mozsystemmonitor 03:43:47 INFO - Successfully installed mozsystemmonitor 03:43:47 INFO - Cleaning up... 03:43:47 INFO - Return code: 0 03:43:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:47 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:47 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==2.5.1'] in /builds/slave/test/build 03:43:47 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==2.5.1 03:43:47 INFO - Using env: {'DISPLAY': ':0', 03:43:47 INFO - 'HOME': '/home/cltbld', 03:43:47 INFO - 'LANG': 'en_US.UTF-8', 03:43:47 INFO - 'LANGUAGE': 'en_US:en', 03:43:47 INFO - 'LOGNAME': 'cltbld', 03:43:47 INFO - 'MAIL': '/var/mail/cltbld', 03:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:47 INFO - 'MOZ_NO_REMOTE': '1', 03:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:47 INFO - 'NO_EM_RESTART': '1', 03:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:47 INFO - 'PWD': '/builds/slave/test', 03:43:47 INFO - 'SHELL': '/bin/bash', 03:43:47 INFO - 'SHLVL': '1', 03:43:47 INFO - 'TERM': 'linux', 03:43:47 INFO - 'TMOUT': '86400', 03:43:47 INFO - 'USER': 'cltbld', 03:43:47 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:47 INFO - '_': '/tools/buildbot/bin/python'} 03:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:47 INFO - Downloading/unpacking jsonschema==2.5.1 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:49 INFO - warning: no files found matching '*.txt' 03:43:49 INFO - no previously-included directories found matching 'build' 03:43:49 INFO - no previously-included directories found matching 'dist' 03:43:49 INFO - no previously-included directories found matching '.git*' 03:43:49 INFO - Installing collected packages: jsonschema, functools32 03:43:49 INFO - Running setup.py install for functools32 03:43:49 INFO - warning: no files found matching '*.txt' 03:43:49 INFO - no previously-included directories found matching 'build' 03:43:49 INFO - no previously-included directories found matching 'dist' 03:43:49 INFO - no previously-included directories found matching '.git*' 03:43:49 INFO - Successfully installed jsonschema functools32 03:43:49 INFO - Cleaning up... 03:43:50 INFO - Return code: 0 03:43:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:43:50 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')]} 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 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')]} 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:50 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:43:50 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 functools32==3.2.3-2 03:43:50 INFO - Using env: {'DISPLAY': ':0', 03:43:50 INFO - 'HOME': '/home/cltbld', 03:43:50 INFO - 'LANG': 'en_US.UTF-8', 03:43:50 INFO - 'LANGUAGE': 'en_US:en', 03:43:50 INFO - 'LOGNAME': 'cltbld', 03:43:50 INFO - 'MAIL': '/var/mail/cltbld', 03:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:50 INFO - 'MOZ_NO_REMOTE': '1', 03:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:50 INFO - 'NO_EM_RESTART': '1', 03:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:50 INFO - 'PWD': '/builds/slave/test', 03:43:50 INFO - 'SHELL': '/bin/bash', 03:43:50 INFO - 'SHLVL': '1', 03:43:50 INFO - 'TERM': 'linux', 03:43:50 INFO - 'TMOUT': '86400', 03:43:50 INFO - 'USER': 'cltbld', 03:43:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:50 INFO - '_': '/tools/buildbot/bin/python'} 03:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:43:50 INFO - Cleaning up... 03:43:50 INFO - Return code: 0 03:43:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:50 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')]} 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 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')]} 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:50 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 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:50 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 03:43:50 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 03:43:50 INFO - Using env: {'DISPLAY': ':0', 03:43:50 INFO - 'HOME': '/home/cltbld', 03:43:50 INFO - 'LANG': 'en_US.UTF-8', 03:43:50 INFO - 'LANGUAGE': 'en_US:en', 03:43:50 INFO - 'LOGNAME': 'cltbld', 03:43:50 INFO - 'MAIL': '/var/mail/cltbld', 03:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:50 INFO - 'MOZ_NO_REMOTE': '1', 03:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:50 INFO - 'NO_EM_RESTART': '1', 03:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:50 INFO - 'PWD': '/builds/slave/test', 03:43:50 INFO - 'SHELL': '/bin/bash', 03:43:50 INFO - 'SHLVL': '1', 03:43:50 INFO - 'TERM': 'linux', 03:43:50 INFO - 'TMOUT': '86400', 03:43:50 INFO - 'USER': 'cltbld', 03:43:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:50 INFO - '_': '/tools/buildbot/bin/python'} 03:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:50 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:53 INFO - Downloading docopt-0.6.1.tar.gz 03:43:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:53 INFO - Running setup.py install for blobuploader 03:43:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:53 INFO - Running setup.py install for requests 03:43:53 INFO - Running setup.py install for docopt 03:43:53 INFO - Successfully installed blobuploader requests docopt 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 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 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:53 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 03:43:53 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 03:43:53 INFO - Using env: {'DISPLAY': ':0', 03:43:53 INFO - 'HOME': '/home/cltbld', 03:43:53 INFO - 'LANG': 'en_US.UTF-8', 03:43:53 INFO - 'LANGUAGE': 'en_US:en', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MAIL': '/var/mail/cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SHLVL': '1', 03:43:53 INFO - 'TERM': 'linux', 03:43:53 INFO - 'TMOUT': '86400', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - '_': '/tools/buildbot/bin/python'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:53 INFO - Running setup.py (path:/tmp/pip-cOiFpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:53 INFO - Running setup.py (path:/tmp/pip-s4VUBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:54 INFO - Running setup.py (path:/tmp/pip-cQ1l9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:54 INFO - Running setup.py (path:/tmp/pip-EqnP9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:54 INFO - Running setup.py (path:/tmp/pip-xhsK_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:54 INFO - Running setup.py (path:/tmp/pip-T2MsbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:54 INFO - Running setup.py (path:/tmp/pip-ZUxFP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:54 INFO - Running setup.py (path:/tmp/pip-JaH3hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:54 INFO - Running setup.py (path:/tmp/pip-sAHVeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:54 INFO - Running setup.py (path:/tmp/pip-x8ViBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:54 INFO - Running setup.py (path:/tmp/pip-lLgyzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:54 INFO - Running setup.py (path:/tmp/pip-fQaR7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:54 INFO - Running setup.py (path:/tmp/pip-nVnXJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:54 INFO - Running setup.py (path:/tmp/pip-ddj4Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:54 INFO - Running setup.py (path:/tmp/pip-wgEfOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:54 INFO - Running setup.py (path:/tmp/pip-puBNQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:55 INFO - Running setup.py (path:/tmp/pip-51dAUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:55 INFO - Running setup.py install for manifestparser 03:43:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozcrash 03:43:55 INFO - Running setup.py install for mozdebug 03:43:55 INFO - Running setup.py install for mozdevice 03:43:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozfile 03:43:55 INFO - Running setup.py install for mozhttpd 03:43:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozinfo 03:43:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozInstall 03:43:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:55 INFO - Running setup.py install for mozleak 03:43:56 INFO - Running setup.py install for mozlog 03:43:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for moznetwork 03:43:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for mozprocess 03:43:56 INFO - Running setup.py install for mozprofile 03:43:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for mozrunner 03:43:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Running setup.py install for mozscreenshot 03:43:56 INFO - Running setup.py install for moztest 03:43:56 INFO - Running setup.py install for mozversion 03:43:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:56 INFO - Cleaning up... 03:43:56 INFO - Return code: 0 03:43:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:56 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 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:43:56 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 03:43:56 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 03:43:56 INFO - Using env: {'DISPLAY': ':0', 03:43:56 INFO - 'HOME': '/home/cltbld', 03:43:56 INFO - 'LANG': 'en_US.UTF-8', 03:43:56 INFO - 'LANGUAGE': 'en_US:en', 03:43:56 INFO - 'LOGNAME': 'cltbld', 03:43:56 INFO - 'MAIL': '/var/mail/cltbld', 03:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:56 INFO - 'MOZ_NO_REMOTE': '1', 03:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:56 INFO - 'NO_EM_RESTART': '1', 03:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:56 INFO - 'PWD': '/builds/slave/test', 03:43:56 INFO - 'SHELL': '/bin/bash', 03:43:56 INFO - 'SHLVL': '1', 03:43:56 INFO - 'TERM': 'linux', 03:43:56 INFO - 'TMOUT': '86400', 03:43:56 INFO - 'USER': 'cltbld', 03:43:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:56 INFO - '_': '/tools/buildbot/bin/python'} 03:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:57 INFO - Running setup.py (path:/tmp/pip-5jHHzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:57 INFO - Running setup.py (path:/tmp/pip-gaKTLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:57 INFO - Running setup.py (path:/tmp/pip-AEWiWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:57 INFO - Running setup.py (path:/tmp/pip-xMXoD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:57 INFO - Running setup.py (path:/tmp/pip-kamw6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:57 INFO - Running setup.py (path:/tmp/pip-00pVWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:57 INFO - Running setup.py (path:/tmp/pip-sn375T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:57 INFO - Running setup.py (path:/tmp/pip-4RfgVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:57 INFO - Running setup.py (path:/tmp/pip-SOdFph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:57 INFO - Running setup.py (path:/tmp/pip-pyVZlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:57 INFO - Running setup.py (path:/tmp/pip-wMqaBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:57 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)) 03:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:57 INFO - Running setup.py (path:/tmp/pip-qJJNQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:58 INFO - Running setup.py (path:/tmp/pip-zJu8rE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:58 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)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:58 INFO - Running setup.py (path:/tmp/pip-W6nYGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:58 INFO - Running setup.py (path:/tmp/pip-xBXQBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:58 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)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:58 INFO - Running setup.py (path:/tmp/pip-gm2agv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:58 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)) 03:43:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:58 INFO - Running setup.py (path:/tmp/pip-KDyypf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:58 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)) 03:43:58 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)) 03:43:58 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)) 03:43:58 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)) 03:43:58 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)) 03:43:58 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)) 03:43:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:00 INFO - Downloading blessings-1.6.tar.gz 03:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:44:00 INFO - Installing collected packages: blessings 03:44:00 INFO - Running setup.py install for blessings 03:44:00 INFO - Successfully installed blessings 03:44:00 INFO - Cleaning up... 03:44:00 INFO - Return code: 0 03:44:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:00 INFO - Reading from file tmpfile_stdout 03:44:00 INFO - Current package versions: 03:44:00 INFO - argparse == 1.2.1 03:44:00 INFO - blessings == 1.6 03:44:00 INFO - blobuploader == 1.2.4 03:44:00 INFO - docopt == 0.6.1 03:44:00 INFO - functools32 == 3.2.3-2 03:44:00 INFO - jsonschema == 2.5.1 03:44:00 INFO - manifestparser == 1.1 03:44:00 INFO - mozInstall == 1.12 03:44:00 INFO - mozcrash == 0.17 03:44:00 INFO - mozdebug == 0.1 03:44:00 INFO - mozdevice == 0.48 03:44:00 INFO - mozfile == 1.2 03:44:00 INFO - mozhttpd == 0.7 03:44:00 INFO - mozinfo == 0.9 03:44:00 INFO - mozleak == 0.1 03:44:00 INFO - mozlog == 3.3 03:44:00 INFO - moznetwork == 0.27 03:44:00 INFO - mozprocess == 0.23 03:44:00 INFO - mozprofile == 0.28 03:44:00 INFO - mozrunner == 6.12 03:44:00 INFO - mozscreenshot == 0.1 03:44:00 INFO - mozsystemmonitor == 0.3 03:44:00 INFO - moztest == 0.7 03:44:00 INFO - mozversion == 1.4 03:44:00 INFO - psutil == 3.1.1 03:44:00 INFO - requests == 1.2.3 03:44:00 INFO - wsgiref == 0.1.2 03:44:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:44:00 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')]} 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 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')]} 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 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 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:44:00 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 03:44:00 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 03:44:00 INFO - Using env: {'DISPLAY': ':0', 03:44:00 INFO - 'HOME': '/home/cltbld', 03:44:00 INFO - 'LANG': 'en_US.UTF-8', 03:44:00 INFO - 'LANGUAGE': 'en_US:en', 03:44:00 INFO - 'LOGNAME': 'cltbld', 03:44:00 INFO - 'MAIL': '/var/mail/cltbld', 03:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:00 INFO - 'MOZ_NO_REMOTE': '1', 03:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:00 INFO - 'NO_EM_RESTART': '1', 03:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:00 INFO - 'PWD': '/builds/slave/test', 03:44:00 INFO - 'SHELL': '/bin/bash', 03:44:00 INFO - 'SHLVL': '1', 03:44:00 INFO - 'TERM': 'linux', 03:44:00 INFO - 'TMOUT': '86400', 03:44:00 INFO - 'USER': 'cltbld', 03:44:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:00 INFO - '_': '/tools/buildbot/bin/python'} 03:44:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 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)) 03:44:00 INFO - Cleaning up... 03:44:00 INFO - Return code: 0 03:44:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:44:00 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')]} 03:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 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')]} 03:44:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:44:00 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 0x2832030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a61400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, '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': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', '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 03:44:00 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 03:44:00 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 03:44:00 INFO - Using env: {'DISPLAY': ':0', 03:44:00 INFO - 'HOME': '/home/cltbld', 03:44:00 INFO - 'LANG': 'en_US.UTF-8', 03:44:00 INFO - 'LANGUAGE': 'en_US:en', 03:44:00 INFO - 'LOGNAME': 'cltbld', 03:44:00 INFO - 'MAIL': '/var/mail/cltbld', 03:44:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:00 INFO - 'MOZ_NO_REMOTE': '1', 03:44:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:00 INFO - 'NO_EM_RESTART': '1', 03:44:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:00 INFO - 'PWD': '/builds/slave/test', 03:44:00 INFO - 'SHELL': '/bin/bash', 03:44:00 INFO - 'SHLVL': '1', 03:44:00 INFO - 'TERM': 'linux', 03:44:00 INFO - 'TMOUT': '86400', 03:44:00 INFO - 'USER': 'cltbld', 03:44:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:44:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:00 INFO - '_': '/tools/buildbot/bin/python'} 03:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:44:01 INFO - Cleaning up... 03:44:01 INFO - Return code: 0 03:44:01 INFO - Running post-action listener: _resource_record_post_action 03:44:01 INFO - Running post-action listener: _start_resource_monitoring 03:44:01 INFO - Starting resource monitoring. 03:44:01 INFO - [mozharness: 2016-09-11 10:44:01.213668Z] Finished create-virtualenv step (success) 03:44:01 INFO - [mozharness: 2016-09-11 10:44:01.214267Z] Running install step. 03:44:01 INFO - Running pre-action listener: _resource_record_pre_action 03:44:01 INFO - Running main action method: install 03:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:44:01 INFO - Reading from file tmpfile_stdout 03:44:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:44:01 INFO - Reading from file tmpfile_stdout 03:44:01 INFO - Output received: 03:44:01 INFO - Usage: mozinstall [options] installer 03:44:01 INFO - Options: 03:44:01 INFO - -h, --help show this help message and exit 03:44:01 INFO - -d DEST, --destination=DEST 03:44:01 INFO - Directory to install application into. [default: 03:44:01 INFO - "/builds/slave/test"] 03:44:01 INFO - --app=APP Application being installed. [default: firefox] 03:44:01 INFO - mkdir: /builds/slave/test/build/application 03:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:44:18 INFO - Reading from file tmpfile_stdout 03:44:18 INFO - Output received: 03:44:18 INFO - /builds/slave/test/build/application/firefox/firefox 03:44:18 INFO - Running post-action listener: _resource_record_post_action 03:44:18 INFO - [mozharness: 2016-09-11 10:44:18.311794Z] Finished install step (success) 03:44:18 INFO - [mozharness: 2016-09-11 10:44:18.312069Z] Running run-tests step. 03:44:18 INFO - Running pre-action listener: _resource_record_pre_action 03:44:18 INFO - Running main action method: run_tests 03:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:18 INFO - Python 2.7.3 03:44:18 INFO - Return code: 0 03:44:18 INFO - grabbing minidump binary from tooltool 03:44:18 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')]} 03:44:18 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af0570>, '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 0x2af1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2af1900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:18 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 03:44:18 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 03:44:18 INFO - Calling ['/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'] with output_timeout 600 03:44:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:18 INFO - Return code: 0 03:44:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:44:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:44:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:18 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/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 03:44:18 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/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 03:44:18 INFO - Using env: {'DISPLAY': ':0', 03:44:18 INFO - 'HOME': '/home/cltbld', 03:44:18 INFO - 'LANG': 'en_US.UTF-8', 03:44:18 INFO - 'LANGUAGE': 'en_US:en', 03:44:18 INFO - 'LOGNAME': 'cltbld', 03:44:18 INFO - 'MAIL': '/var/mail/cltbld', 03:44:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:18 INFO - 'MOZ_NO_REMOTE': '1', 03:44:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:18 INFO - 'NO_EM_RESTART': '1', 03:44:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:18 INFO - 'PWD': '/builds/slave/test', 03:44:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:18 INFO - 'SHELL': '/bin/bash', 03:44:18 INFO - 'SHLVL': '1', 03:44:18 INFO - 'TERM': 'linux', 03:44:18 INFO - 'TMOUT': '86400', 03:44:18 INFO - 'USER': 'cltbld', 03:44:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107', 03:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:18 INFO - '_': '/tools/buildbot/bin/python'} 03:44:18 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/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 03:44:18 INFO - mozversion application_buildid: 20160911004011 03:44:18 INFO - mozversion application_changeset: 8663d41e015f3c9933a08a65c8349b86f2263354 03:44:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:44:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:18 INFO - mozversion application_name: Firefox 03:44:18 INFO - mozversion application_remotingname: firefox-dev 03:44:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:44:18 INFO - mozversion application_vendor: Mozilla 03:44:18 INFO - mozversion application_version: 50.0a2 03:44:18 INFO - mozversion platform_buildid: 20160911004011 03:44:18 INFO - mozversion platform_changeset: 8663d41e015f3c9933a08a65c8349b86f2263354 03:44:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:44:18 INFO - mozversion platform_version: 50.0a2 03:44:18 INFO - using testdate: 1473590658 03:44:18 INFO - actual date: 1473590658 03:44:18 INFO - starting webserver on 'localhost:51696' 03:44:18 INFO - SUITE-START | Running 2 tests 03:44:18 INFO - TEST-START | dromaeo_css 03:44:18 INFO - operating with platform_type : linux_ 03:44:18 INFO - Initialising browser for dromaeo_css test... 03:44:18 INFO - TEST-INFO | started process 9578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjBBB1C/profile http://localhost:51696/getInfo.html) 03:44:23 INFO - PROCESS | 9578 | __metrics Screen width/height:1600/1200 03:44:23 INFO - PROCESS | 9578 | colorDepth:24 03:44:23 INFO - PROCESS | 9578 | Browser inner width/height: 1024/697 03:44:23 INFO - PROCESS | 9578 | __metrics 03:44:23 ERROR - PROCESS | 9578 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:44:24 INFO - TEST-INFO | 9578: exit 0 03:44:24 INFO - Browser initialized. 03:44:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:24 INFO - TEST-INFO | started process 9707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjBBB1C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:36 INFO - PROCESS | 9707 | RSS: Main: 153051136 03:44:36 INFO - PROCESS | 9707 | 03:45:26 INFO - PROCESS | 9707 | 1473590726120 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] 03:47:34 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51696/tests/dromaeo/cssquery-ext.html) 03:47:35 INFO - PROCESS | 9707 | RSS: Main: 159608832 03:47:35 INFO - PROCESS | 9707 | 03:50:37 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-ext.html (next: http://localhost:51696/tests/dromaeo/cssquery-jquery.html) 03:50:38 INFO - PROCESS | 9707 | RSS: Main: 156266496 03:50:38 INFO - PROCESS | 9707 | 03:53:40 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51696/tests/dromaeo/cssquery-mootools.html) 03:53:40 INFO - PROCESS | 9707 | RSS: Main: 156262400 03:53:40 INFO - PROCESS | 9707 | 03:56:42 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51696/tests/dromaeo/cssquery-prototype.html) 03:56:43 INFO - PROCESS | 9707 | RSS: Main: 154730496 03:56:43 INFO - PROCESS | 9707 | 03:59:45 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51696/tests/dromaeo/cssquery-yui.html) 03:59:46 INFO - PROCESS | 9707 | RSS: Main: 157503488 03:59:46 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | Cycle 1(1): loaded http://localhost:51696/tests/dromaeo/cssquery-yui.html (next: http://localhost:51696/tests/dromaeo/cssquery-dojo.html) 04:02:48 INFO - PROCESS | 9707 | RSS: Main: 157548544 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | __start_tp_report 04:02:48 INFO - PROCESS | 9707 | _x_x_mozilla_page_load 04:02:48 INFO - PROCESS | 9707 | _x_x_mozilla_page_load_details 04:02:48 INFO - PROCESS | 9707 | |i|pagename|runs| 04:02:48 INFO - PROCESS | 9707 | |0;dojo.html;3296.4231259529583;3311.12255252358;3323.036319467353;3323.202431416459;3334.099793055875;5656.57575681824;5712.086066229404;5748.885022299557;5789.710514474281;5799.797007104752;5779.82660520184;5808.883822323562;5834.095715164156;5851.2100866383025;5857.8828423431505;5222.608304377178;5285.947140528603;5290.365156181264;5363.2491451196665;5365.141577347626;5202.193659982709;5203.739813009353;5224.216367544861;5277.340332458442;5305.840824775243;5325.4940780625975;5328.280682107924;5335.493128152839;5344.22508736233;5400.891982160354;5373.892522149574;5382.838514844541;5385.865353366197;5394.946050539484;5408.648437851527;5033.345665063518;5162.896742065138;5179.8446046618665;5275.129603615399;5299.54953828925;5165.560927321182;5704.600677952545;5720.256366672306;5766.769329226826;5833.095870140135;6195.44241018306;6237.157983672191;6238.033104868752;6249.343818899041;6253.437190652818;6044.2746870375395;6235.158253635746;6276.403741644536;6278.843028924268;6280.717367718464;5689.374168841424;5749.511291540182;5751.1085781703905;5802.593818432669;5848.444397782204;6239.06414037898;6288.056791481315;6327.4938004959495;6328.082428047907;6330.493560515148;5917.704114794243;6092.695365231721;6103.054026625791;6116.602420842631;6132.908006379907;6108.236470441195;6177.104319873593;6194.349593292639;6300.149479820166;6311.589746666452;6204.5967012144065;6243.125962365272;6263.248410190715;6266.749330026748;6268.279147897959;6017.729202185825;6255.311915689271;6276.372362763687;6286.057091436322;6289.842753931097;4703.270992996091;4726.503717109723;4750.026244619845;4775.450823155312;4811.591014763784;4232.851850185229;4242.4272723181975;4245.893852653709;4251.17102165081;4261.488621365394;5679.403662615448;5942.405759424109;6000.5799594028;6006.399360064046;6017.608855424383;6162.168107305546;6168.506519478431;6194.535409844189;6299.559030867887;6326.9683651581445;5924.111383292455;5973.701314934236;5975.52195824333;5979.730912108966;6017.157597936292;5231.555317797954;5400;5408.161734931092;5409.323834520685;5412.5940554458575;6291;6328.905066424008;6384.297727249998;6480.805575832733;6487.578307410004;6251.187345645037;6288.717007734572;6298.84252893663;6301;6307.90538141919;6139.26328840542;6421.101045853491;6473.061406096184;6482.70827812759;6486.610803351814;6035.6076855004285;6075.939240607714;6079.240094988127;6147.016477363601;6173.938260617337;6242.344553821783;6252.437280644764;6256;6267.059941008885;6282;6126.693665316628;6136.907946380898;6145.139680444652;6147.66187859672;6158.076288556752;5848.239728835224;5980.282366116094;5998;6058.091286307089;6108.979583722478;5951.523878089829;6004.579679422399;6016.729247183975;6021.698915054142;6068.8786224276155;6067.54493412987;6081.5134789217645;6110.938890611037;6119.173911521888;6119.204503414528;5817.7963771267805;5847.1229315601295;5915.674637894785;5924.674142922008;5996.340402555628 04:02:48 INFO - PROCESS | 9707 | |1;ext.html;588.9469947704706;643.2795269298387;659.3604203922197;666.187251553105;666.8366250268685;35192;46356.304655430155;47309.29036064462;47338.053238935245;47609.52390476094;49152.26271605929;49471.25793113106;49498.50501494984;49749.25376119361;49751.25373119406;9194.724158275245;9296.349255552113;9319.62721491143;9336.906630933705;9338.906610933906;9029.142231487998;9097.63609455621;9157.816843663122;9196.908030919705;9211.078892110801;9169.862452063224;9261;9262.351635385527;9270.860937085916;9303.627854885797;9173.816523669557;9226.584803683816;9262.027487113857;9280.90719092814;9287.349885508018;9205;9301.976782553913;9306.953465232698;9309.208717258973;9311.02234265406;46790.53209467896;46856;47258.76370618159;47264.7636761814;47383.76308118437;3780.3573392523335;3859.3439115350457;3946.842126314944;3954.8418063277436;3973.4238535412205;31850.681493185235;32189.83905080483;32234.194145146324;34920;37081.25837483235;4499.662525310615;4502.189605870942;4510.323451482304;4519.909601807978;4596.4254468191475;383785;387529;387540;389732;390345;38631.42052869209;39904.201915961516;64957;65110.67444662746;65128;41561.58438415638;41950;42088.158236835094;42103.15793684109;42107.15785684269;17720.20259088344;17728;17757;17802;17860.55348616295;15027.474038408604;15098.54704358849;15118.395264189308;15165.924170379298;15176.165310907785;9244.583993720298;9248.398854074463;9291.814163716688;9378.249740020781;9435;3541.94687079694;3571.8571257149943;3587.587427445877;3597.172650290448;3607.6211997740384;1082.653550863716;1104.276698762312;1120.506976930148;1186.9347185904685;1216.1183142221996;35119.4732079019;35452.468212976826;35522.11194720153;35695.10762230913;35755.46366804448;1239.2812168941991;1255.4350542256022;1286.6847622332402;1289.1362786932777;1324.2857071735432;17823.73264401035;18304;18324.267029318944;18776.71834922477;18948.43154705361;603602;606026;609311;614115;618106;66746;67053;67131;67285;67368.32631673719;1440.0855456784807;1453.0700351774872;1463.5828788795143;1504.5787179589731;1520.361448191762;34036.659633403346;34063.829680851435;34441.48337774986;34460.82769586136;34660.82669586636;57582.136267956856;58106.7094664524;58163.70918145382;58173.127403089835;58345.12482312684;511968;513070;513428;514925;515136;31550.684493154775;31632;31752;31945.6805431952;32103.67896321007;53744.731276343366;54153.45846541642;54408.727956359966;54592.181117282475;55178.72410637921;46041.30938035999;46373.304400434696;46785.53214467948;47749;48663.02673946572;46351.76824115858;46585.767071164424;47245.76377118092;47332;47718.761406194135;45257.77371113123;45771.77114114408;46744;46746.76626616845;46860.53139468562;38644.420333694456;40462.19075618412;40735;41117.177656447304;41607.37588936108;31088.22279443032;31197.844010780707;31332;31414.214644634067;31584 04:02:48 INFO - PROCESS | 9707 | |2;jquery.html;414.1303263147391;416.35257175092755;428.07322147550553;434.72829481574024;435.85398891371386;19872.503187420305;20929.37211883642;21512.784872151275;21564.784352156512;21641.242556510526;20554.280600178998;20577.27979520717;20706.585868282662;20944.685829712565;21158.894205528988;5624.437556244374;5919.940800591982;5922.733476993524;5932.37710040446;5943;5628.409017053192;5770.769169233246;5800.506956908646;5807.419258074201;5826.242588463494;5728.484436400723;5765.250517432728;5766.9711651441685;5799.565032622549;5801.767929282844;5606.383297837235;5823.708814559276;5907.1434641976675;5910.4089591040765;5921.61509501881;5254.106801843695;5270.7628156733035;5285.577153827723;5294.126469132627;5306.204069389622;24524.264272071865;25004.624930626054;25012.249632511055;25043.749562504323;25085.4982900341;2534.6451496790464;2548.3119557719497;2588.1459118491043;2764.5853122031654;3105.6117985251844;15571.299291531908;15777.921110394489;15786.131762753044;16109.83890161095;16620.50138495835;1989.7910719374402;2008.3673642802617;2017.2536161620149;2017.778044415113;2114.4185349028985;57232.6700468288;83836.74244886392;84347;85410.14589854084;87708.56145719295;11544.365059921616;11700.824487632692;11721.179517433868;12045.819312710317;12411.069169812301;16383.59041023984;16396.344146234016;16428.917855410884;16434.83565164333;16485.58786030359;8698.433002878162;8964.551772411354;9088.772780680403;9221.308401869886;9223.077692230723;8931.955340223258;9014.684486043088;9040;9177.77055573616;9250.398724083048;7121.9643901780155;7165.140183178052;7221.205667376585;7308.96345518269;7328.3404493595835;1999.3402177281462;2035.1452389996236;2064.886431246296;2092.7174831397565;2106.24175296893;1026.5483187397522;1067.1942683274078;1076.5586109694987;1083.6369816111533;1101.6915263726169;21096.78903210979;21219.68170477444;21449.785502145092;21620.736698499317;21667.133314667553;1046.9685909422728;1068.3536460441476;1069.4652673663168;1095.7205912492263;1124.8312753087102;11295.661130166109;12301;12450.128491005724;12477.31374774378;12560.371981401076;529336;534042;551205;561133;562598;82456;83131.5843420779;84027;84737;85129;1073.3988966178808;1084.983725244122;1104.9779004419865;1112.0491979357532;1117.0337657925836;18705.53236169107;18896;18966.905165474636;19071.427857164308;19144;41280;41432.1713565721;41472.79263603783;41542;42664;54584;55381;55632;57230.71384643217;57275.42724572701;8843;8878.822423551623;8962.32782541299;9022.819543608959;9260;8514.680224565202;8914.86627700572;13327.200367977952;13483.730325393633;13507.864921350661;10809.405482698527;10851.837222441827;11104.777904441704;11172.49723762449;11533.192676512563;11412.201145919706;11613.593524226611;12113.15207935436;12139.939300303442;12171.2697238166;6078.54410919174;10513.053825155772;11483.483243253906;12049.51801927913;12411.379431028232;8761.211490965843;8854.070322616033;8921.643134274816;9144.58849351794;9240.260779137518;11478.827817582576;11805.23265987708;11860.584879529175;12272.202306850026;12432.12975091735 04:02:48 INFO - PROCESS | 9707 | |3;mootools.html;1578.2345562402236;1578.3686525389842;1765.887490880745;1867.113121267399;1889.971650425243;8630.180132887366;9219.907800921988;9298;9928;9949.353292036012;9296.535173241346;9642.2768292378;9671.468069256189;9686.66096686616;9718.173955213797;2508.3729067733066;2544.0586982816385;2548.4138648110948;2550.681164854393;2553.706323772762;2501.2746303571944;2539.885705143273;2550.0947163756878;2553.9361515962155;2563.8333508321994;2460.5817011108156;2463.5319289335057;2475.504899020194;2503.7120731115883;2504.2362079565723;2406.1578447543307;2420.1892366057305;2429.441228517442;2476.26950049734;2478.491909158618;2397.0651445935923;2414.4446777241155;2419.552382809186;2424.187897054489;2452.3869032741813;9615.086566776215;9686.806263874683;9707.70876873695;9734.805303893883;9744.853827192597;5745.310562732457;5771.740271687784;5867.471927526543;5886.7939622113445;5911.29064512257;3632.0556655269556;3670.137517683342;3717.5910649828766;3731.7574357666663;3811.7141214408753;1196.3539688568162;1207.7161866961258;1219.1222319929636;1219.9085068619888;1243.4280231093708;13954.302284885816;13967;14055;14088.647783805385;14096;4960.826371076995;5045.394552653705;5137.563307118862;5185.974070129625;5205.297284866495;11633.41832908368;11692.532298708127;11712.648620541397;11718.70703232426;11774;5828.417158284137;5828.737706803204;5859.794907178229;5870.119482077723;5870.442307980735;4530.320451932236;5292.206169074592;5370.087085195526;5404.891902161935;5550.028744969614;4416.359627854007;4461.933071003873;4468.173387923244;4500.797464114123;4519.209138400766;1345.8990575706862;1391.4156054457153;1397.1407584335561;1404.3189053309136;1418.666613345863;1058.3438268273567;1060.692399204222;1065.3394895165047;1065.840123981409;1082.8862969388258;6316.968415157895;6422.229332480132;6569.343065693488;6678.899816502756;6782.118324617768;1022.2588623248234;1029.8455231715302;1040.891450605103;1054.9103326217205;1073.3452593917705;4381.583749543788;4383.473983122046;4470.709403888737;4584.770761461914;4650.930236046462;12073.33596652175;12268.202566833128;12472.875271247352;12484.500619975099;12494.25034497915;12305.384730763426;12345.691357716129;12387.380630968415;12415;12434.129610927148;8692.652293908173;8859.734207973772;8865.955670221736;8940.105989401138;9037.50293733851;6666.699998500176;6795.354441328066;6820.863582728417;6862.176538815174;6933.583984960918;10866.348019118877;11228.10175185967;11416.372099534605;11514.078873689918;11528.250663706833;11079.446027698421;11247.212695111264;11405.258658187191;11431.828522572001;11582.88417115818;8201.671933122609;8394.622241999003;8452.661893524437;8654.134586541295;8695.826083478421;9743.707688769347;9789.559469824018;9791.314607977372;9851.162651174443;9853.901460985586;8602.18279263469;8625.827483450421;8725.781855453664;8754.737357879274;8817.559122044;8265.256126948603;8348.749537513884;8485.490870547786;8560.186782255676;8634.870476942977;7736.458447908817;7856.7250146244605;7865.213478652089;7876.291133797986;7889.566073865993;5673.375928647928;5770.711464426678;5840.240768700211;5850.327212370632;5924.200232968494;5739.282589676291;5792.333881603501;5801.419858014165;5859.619124756877;5966.075258334965 04:02:48 INFO - PROCESS | 9707 | |4;prototype.html;348.8116417134747;356.4403885899139;358.369270084651;360.814180696941;362.84760400631717;5655.3779084300695;5712.97166510028;5865.1202319652075;5870.148828419882;5924.074675730389;5707.6290041147295;5748.2527271454655;5756.654600723959;5756.683382413966;5761.539076873851;4480.731156130626;4482.439695038121;4518.638508919295;4530.003399252176;4532;4443.22243607369;4504.527024662412;4512.052468981517;4516.932246016296;4535.841245556406;4458.687891847572;4464.285714285715;4469.44131983502;4479.910401791978;4503.639708823286;4471.4857791353925;4486.416765820439;4489.416375871148;4507.977460112711;4521.660875434355;3840.711946603988;3907.27715372657;3909.257241124177;3926.489556357684;3933.115049113955;5586.832395028156;5603.915941260884;5645.266115405012;5645.604807663465;5700.23046888673;5000.499950005007;5133.383993920716;5162;5175.974120129413;5185.481451854822;5929.399062253167;6003.759849606011;6003.969980150115;6009.1587177795145;6012.819615411545;4316.287812510932;4331.242032644306;4352.064306174188;4356.869293921188;4369.825206991716;5991.910121348184;6197.287311959138;6293.496520278367;6322.683865806691;6350.618962862243;4384;4417.425734654475;4444.355568442623;4450.5549445055885;4466.39703640011;4461.687681862303;4502.851772797915;4502.864914052584;4520.547945205453;4537.115262523776;4947.307376967227;5105.770240339194;5161.354830646169;5170.80240897617;5184.196449550326;5876.647401155944;6051.425114614105;6058.1518587397795;6072.574919755663;6078.939210607926;1520.9619759506102;1546.8685161761377;1565.0844256110076;1569.7834178511516;1571.9921400393152;952.1668540027476;979.7501637082498;980.3970558106713;989;993.339429279521;5170.379554453414;5230.320058392384;5251.6061295403;5259.552938000313;5295.391030031518;5506.284183056177;5529.783447641513;5538.175530479404;5549.72251387429;5555.611107222537;5079.238114282887;5187.974060129675;5225.5819534437915;5241.633085684041;5261.657992230493;2940.9852950735108;2942.4997750382486;2946.351802603424;2946.3942151527467;2951.4539810135193;5669.43305669438;5685.6304340218585;5711.685857277889;5712.971435142797;5718.884817460638;5200.531952124251;5540.612157148961;5628.831135065954;5635.351934527582;5645.407232240637;5695.772169113189;5752.194692743019;5757;5767.702266989978;5778.855528611734;5536.031194540858;5566.387697353207;5593.300837395325;6021.7591296347655;6280.591761535486;6208.689565521796;6211;6216.285127210429;6220;6233.781817636361;6309.274433440213;6450.870982580416;6502.544821862613;6524.510661700297;6529.183852018497;4281.666491761935;4332.241857674957;4346.500152482505;4356.237658409829;4363.105563359567;6058.939685555099;6102.176206212104;6331.860265152317;6348.206474190726;6354.538456155018;6072.726727297194;6096.817095487142;6155.983568051712;6161.44546990773;6167.691615419121;6117;6120.693965301806;6134.325224225242;6135.9386406137155;6148.723307451086;5811.302643682785;6054.576179667557;6063.848403789941;6083.239595050619;6083.908741368795;6178.969105154445;6180.165677633642;6201;6241.687915604292;6251.124842522141;5848.64908105515;5923.466887980103;5935.792247271324;5984.970075149597;6022.2171117754415 04:02:48 INFO - PROCESS | 9707 | |5;yui.html;858.5492616376406;862.8533149364607;870.6386849457474;893.6470094312747;948.3314263444264;16204.351825926964;17984.910075449636;18064.27742890286;18111.90944045281;18238.361657341997;16179.83820161798;16422.26099825508;16503.917480412612;16591.502254932373;16596.25316860741;900.3427497926501;903.1284810158229;926.3978414030901;928.3037721708719;929.0848514213494;914.1270087066869;914.8399030169727;914.862770584411;916.9633214671405;922.1792604581927;955.4697143085584;957.3681370295607;957.6504575829841;958.8178246133248;959.1559427703611;944.6552008516876;947.6162154327509;949.2026697574037;949.8195342884865;951.3578334624101;692.5879101934341;696.9930300696979;697.4594689115925;698.9685464154126;699.4124935054527;17652.91173544137;17660.02869842158;17771.289148434047;17780.822191778174;17795.73306400405;16794.748078778826;16795.16024198785;17131.14344282793;17199.140042997926;17399.173086825955;12947.611571652866;13337.333133343294;13367.264800435973;13549.187048777105;13657;3998.300297447964;4033.1127152026506;4047.028713108862;4135.875923722293;4138.8344466221315;90654.5467272666;90769;91350.08649913482;91702.54148729214;94896.99999999932;12482.251064936132;12816.615501534969;12853.742925141445;13150.276734779487;13373.799393009112;23433.06267749305;23451.765482345298;23560.64659030116;23725.644115338284;24267.63598546023;8331.6667333306;9058;9136.543172841331;9155.221806146552;9193.816123677489;5199.454057324002;5251.501107394792;5310.92033619496;5334.013207556614;5342.465753424704;3851.1527463957887;3968.9603103969166;3989.3617021277037;3998.900027499336;4005.0387906902715;678.6945874356559;689.427774946793;765.2462324610254;806.5604245685997;811.8416908702865;756.7200135949623;798.3014861995754;832.7376876283951;853;854.6837670061992;10924.235303528836;11374.886251137548;11383.215661263936;11493.310401375944;11697.707557311136;732.7179036071044;816.9918300817035;826.8181000179951;836.6695155413578;840.2060053249743;5235.397929238186;5522.487761592809;5602.52378547828;5642.689652069175;5663.575231857545;69409.65295173491;71156.64421677962;125623.37188314182;138530;140738.2963085178;119474;119576;120757;121630.39184804019;124802.37598812129;88122;101052.49473752732;101591;102281;105259;10344.810346809913;10427.426491543038;10458.372497650165;10624.787504249716;10625.309354891908;58313.125303121335;59753.701231493564;59872.40127598668;59966.700166498886;61254;49496.50503494919;81618.59190704009;86169.13830861611;86218;88641.55679221563;13026.2835544046;13260.867391326348;13332.533361332307;13424.127431716906;13437.126586771828;14665.92667036658;15370.385184592491;15539;15638.9218053909;15705.68588628244;13611.31943402806;13658.863411365759;13663.385147668578;13851;13871;14163.150210987375;14254.358553864893;14769;15402;15414.46049388266;14039.578812635636;14669.853301466848;14804.62988425298;15057.924710376377;15164.620884477976;11738.390806877762;11950.760984780429;12367.876321236672;12698;12798.104132710621;10851.565937362733;11000;11340.489677964346;11545.13411494158;12122.878771212176 04:02:48 INFO - PROCESS | 9707 | __end_tp_report 04:02:48 INFO - PROCESS | 9707 | __start_cc_report 04:02:48 INFO - PROCESS | 9707 | _x_x_mozilla_cycle_collect,333 04:02:48 INFO - PROCESS | 9707 | __end_cc_report 04:02:48 INFO - PROCESS | 9707 | __startTimestamp1473591768794__endTimestamp 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | ------- Summary: start ------- 04:02:48 INFO - PROCESS | 9707 | Number of tests: 6 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#0] dojo.html Cycles:165 Average:5769.66 Median:6004.58 stddev:662.14 (11.0%) stddev-sans-first:635.11 04:02:48 INFO - PROCESS | 9707 | Values: 3296.4 3311.1 3323.0 3323.2 3334.1 5656.6 5712.1 5748.9 5789.7 5799.8 5779.8 5808.9 5834.1 5851.2 5857.9 5222.6 5285.9 5290.4 5363.2 5365.1 5202.2 5203.7 5224.2 5277.3 5305.8 5325.5 5328.3 5335.5 5344.2 5400.9 5373.9 5382.8 5385.9 5394.9 5408.6 5033.3 5162.9 5179.8 5275.1 5299.5 5165.6 5704.6 5720.3 5766.8 5833.1 6195.4 6237.2 6238.0 6249.3 6253.4 6044.3 6235.2 6276.4 6278.8 6280.7 5689.4 5749.5 5751.1 5802.6 5848.4 6239.1 6288.1 6327.5 6328.1 6330.5 5917.7 6092.7 6103.1 6116.6 6132.9 6108.2 6177.1 6194.3 6300.1 6311.6 6204.6 6243.1 6263.2 6266.7 6268.3 6017.7 6255.3 6276.4 6286.1 6289.8 4703.3 4726.5 4750.0 4775.5 4811.6 4232.9 4242.4 4245.9 4251.2 4261.5 5679.4 5942.4 6000.6 6006.4 6017.6 6162.2 6168.5 6194.5 6299.6 6327.0 5924.1 5973.7 5975.5 5979.7 6017.2 5231.6 5400.0 5408.2 5409.3 5412.6 6291.0 6328.9 6384.3 6480.8 6487.6 6251.2 6288.7 6298.8 6301.0 6307.9 6139.3 6421.1 6473.1 6482.7 6486.6 6035.6 6075.9 6079.2 6147.0 6173.9 6242.3 6252.4 6256.0 6267.1 6282.0 6126.7 6136.9 6145.1 6147.7 6158.1 5848.2 5980.3 5998.0 6058.1 6109.0 5951.5 6004.6 6016.7 6021.7 6068.9 6067.5 6081.5 6110.9 6119.2 6119.2 5817.8 5847.1 5915.7 5924.7 5996.3 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#1] ext.html Cycles:180 Average:66678.63 Median:46196.54 stddev:136222.78 (294.9%) stddev-sans-first:136514.55 04:02:48 INFO - PROCESS | 9707 | Values: 588.9 643.3 659.4 666.2 666.8 35192.0 46356.3 47309.3 47338.1 47609.5 49152.3 49471.3 49498.5 49749.3 49751.3 9194.7 9296.3 9319.6 9336.9 9338.9 9029.1 9097.6 9157.8 9196.9 9211.1 9169.9 9261.0 9262.4 9270.9 9303.6 9173.8 9226.6 9262.0 9280.9 9287.3 9205.0 9302.0 9307.0 9309.2 9311.0 46790.5 46856.0 47258.8 47264.8 47383.8 3780.4 3859.3 3946.8 3954.8 3973.4 31850.7 32189.8 32234.2 34920.0 37081.3 4499.7 4502.2 4510.3 4519.9 4596.4 383785.0 387529.0 387540.0 389732.0 390345.0 38631.4 39904.2 64957.0 65110.7 65128.0 41561.6 41950.0 42088.2 42103.2 42107.2 17720.2 17728.0 17757.0 17802.0 17860.6 15027.5 15098.5 15118.4 15165.9 15176.2 9244.6 9248.4 9291.8 9378.2 9435.0 3541.9 3571.9 3587.6 3597.2 3607.6 1082.7 1104.3 1120.5 1186.9 1216.1 35119.5 35452.5 35522.1 35695.1 35755.5 1239.3 1255.4 1286.7 1289.1 1324.3 17823.7 18304.0 18324.3 18776.7 18948.4 603602.0 606026.0 609311.0 614115.0 618106.0 66746.0 67053.0 67131.0 67285.0 67368.3 1440.1 1453.1 1463.6 1504.6 1520.4 34036.7 34063.8 34441.5 34460.8 34660.8 57582.1 58106.7 58163.7 58173.1 58345.1 511968.0 513070.0 513428.0 514925.0 515136.0 31550.7 31632.0 31752.0 31945.7 32103.7 53744.7 54153.5 54408.7 54592.2 55178.7 46041.3 46373.3 46785.5 47749.0 48663.0 46351.8 46585.8 47245.8 47332.0 47718.8 45257.8 45771.8 46744.0 46746.8 46860.5 38644.4 40462.2 40735.0 41117.2 41607.4 31088.2 31197.8 31332.0 31414.2 31584.0 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#2] jquery.html Cycles:180 Average:30888.81 Median:25064.62 stddev:89774.42 (358.2%) stddev-sans-first:89997.10 04:02:48 INFO - PROCESS | 9707 | Values: 414.1 416.4 428.1 434.7 435.9 19872.5 20929.4 21512.8 21564.8 21641.2 20554.3 20577.3 20706.6 20944.7 21158.9 5624.4 5919.9 5922.7 5932.4 5943.0 5628.4 5770.8 5800.5 5807.4 5826.2 5728.5 5765.3 5767.0 5799.6 5801.8 5606.4 5823.7 5907.1 5910.4 5921.6 5254.1 5270.8 5285.6 5294.1 5306.2 24524.3 25004.6 25012.2 25043.7 25085.5 2534.6 2548.3 2588.1 2764.6 3105.6 15571.3 15777.9 15786.1 16109.8 16620.5 1989.8 2008.4 2017.3 2017.8 2114.4 57232.7 83836.7 84347.0 85410.1 87708.6 11544.4 11700.8 11721.2 12045.8 12411.1 16383.6 16396.3 16428.9 16434.8 16485.6 8698.4 8964.6 9088.8 9221.3 9223.1 8932.0 9014.7 9040.0 9177.8 9250.4 7122.0 7165.1 7221.2 7309.0 7328.3 1999.3 2035.1 2064.9 2092.7 2106.2 1026.5 1067.2 1076.6 1083.6 1101.7 21096.8 21219.7 21449.8 21620.7 21667.1 1047.0 1068.4 1069.5 1095.7 1124.8 11295.7 12301.0 12450.1 12477.3 12560.4 529336.0 534042.0 551205.0 561133.0 562598.0 82456.0 83131.6 84027.0 84737.0 85129.0 1073.4 1085.0 1105.0 1112.0 1117.0 18705.5 18896.0 18966.9 19071.4 19144.0 41280.0 41432.2 41472.8 41542.0 42664.0 54584.0 55381.0 55632.0 57230.7 57275.4 8843.0 8878.8 8962.3 9022.8 9260.0 8514.7 8914.9 13327.2 13483.7 13507.9 10809.4 10851.8 11104.8 11172.5 11533.2 11412.2 11613.6 12113.2 12139.9 12171.3 6078.5 10513.1 11483.5 12049.5 12411.4 8761.2 8854.1 8921.6 9144.6 9240.3 11478.8 11805.2 11860.6 12272.2 12432.1 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#3] mootools.html Cycles:180 Average:6461.55 Median:4485.75 stddev:3726.84 (83.1%) stddev-sans-first:3719.23 04:02:48 INFO - PROCESS | 9707 | Values: 1578.2 1578.4 1765.9 1867.1 1890.0 8630.2 9219.9 9298.0 9928.0 9949.4 9296.5 9642.3 9671.5 9686.7 9718.2 2508.4 2544.1 2548.4 2550.7 2553.7 2501.3 2539.9 2550.1 2553.9 2563.8 2460.6 2463.5 2475.5 2503.7 2504.2 2406.2 2420.2 2429.4 2476.3 2478.5 2397.1 2414.4 2419.6 2424.2 2452.4 9615.1 9686.8 9707.7 9734.8 9744.9 5745.3 5771.7 5867.5 5886.8 5911.3 3632.1 3670.1 3717.6 3731.8 3811.7 1196.4 1207.7 1219.1 1219.9 1243.4 13954.3 13967.0 14055.0 14088.6 14096.0 4960.8 5045.4 5137.6 5186.0 5205.3 11633.4 11692.5 11712.6 11718.7 11774.0 5828.4 5828.7 5859.8 5870.1 5870.4 4530.3 5292.2 5370.1 5404.9 5550.0 4416.4 4461.9 4468.2 4500.8 4519.2 1345.9 1391.4 1397.1 1404.3 1418.7 1058.3 1060.7 1065.3 1065.8 1082.9 6317.0 6422.2 6569.3 6678.9 6782.1 1022.3 1029.8 1040.9 1054.9 1073.3 4381.6 4383.5 4470.7 4584.8 4650.9 12073.3 12268.2 12472.9 12484.5 12494.3 12305.4 12345.7 12387.4 12415.0 12434.1 8692.7 8859.7 8866.0 8940.1 9037.5 6666.7 6795.4 6820.9 6862.2 6933.6 10866.3 11228.1 11416.4 11514.1 11528.3 11079.4 11247.2 11405.3 11431.8 11582.9 8201.7 8394.6 8452.7 8654.1 8695.8 9743.7 9789.6 9791.3 9851.2 9853.9 8602.2 8625.8 8725.8 8754.7 8817.6 8265.3 8348.7 8485.5 8560.2 8634.9 7736.5 7856.7 7865.2 7876.3 7889.6 5673.4 5770.7 5840.2 5850.3 5924.2 5739.3 5792.3 5801.4 5859.6 5966.1 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#4] prototype.html Cycles:180 Average:4976.02 Median:5598.61 stddev:1460.25 (26.1%) stddev-sans-first:1422.44 04:02:48 INFO - PROCESS | 9707 | Values: 348.8 356.4 358.4 360.8 362.8 5655.4 5713.0 5865.1 5870.1 5924.1 5707.6 5748.3 5756.7 5756.7 5761.5 4480.7 4482.4 4518.6 4530.0 4532.0 4443.2 4504.5 4512.1 4516.9 4535.8 4458.7 4464.3 4469.4 4479.9 4503.6 4471.5 4486.4 4489.4 4508.0 4521.7 3840.7 3907.3 3909.3 3926.5 3933.1 5586.8 5603.9 5645.3 5645.6 5700.2 5000.5 5133.4 5162.0 5176.0 5185.5 5929.4 6003.8 6004.0 6009.2 6012.8 4316.3 4331.2 4352.1 4356.9 4369.8 5991.9 6197.3 6293.5 6322.7 6350.6 4384.0 4417.4 4444.4 4450.6 4466.4 4461.7 4502.9 4502.9 4520.5 4537.1 4947.3 5105.8 5161.4 5170.8 5184.2 5876.6 6051.4 6058.2 6072.6 6078.9 1521.0 1546.9 1565.1 1569.8 1572.0 952.2 979.8 980.4 989.0 993.3 5170.4 5230.3 5251.6 5259.6 5295.4 5506.3 5529.8 5538.2 5549.7 5555.6 5079.2 5188.0 5225.6 5241.6 5261.7 2941.0 2942.5 2946.4 2946.4 2951.5 5669.4 5685.6 5711.7 5713.0 5718.9 5200.5 5540.6 5628.8 5635.4 5645.4 5695.8 5752.2 5757.0 5767.7 5778.9 5536.0 5566.4 5593.3 6021.8 6280.6 6208.7 6211.0 6216.3 6220.0 6233.8 6309.3 6450.9 6502.5 6524.5 6529.2 4281.7 4332.2 4346.5 4356.2 4363.1 6058.9 6102.2 6331.9 6348.2 6354.5 6072.7 6096.8 6156.0 6161.4 6167.7 6117.0 6120.7 6134.3 6135.9 6148.7 5811.3 6054.6 6063.8 6083.2 6083.9 6179.0 6180.2 6201.0 6241.7 6251.1 5848.6 5923.5 5935.8 5985.0 6022.2 04:02:48 INFO - PROCESS | 9707 | 04:02:48 INFO - PROCESS | 9707 | [#5] yui.html Cycles:180 Average:23115.35 Median:23996.64 stddev:33674.26 (140.3%) stddev-sans-first:33727.26 04:02:48 INFO - PROCESS | 9707 | Values: 858.5 862.9 870.6 893.6 948.3 16204.4 17984.9 18064.3 18111.9 18238.4 16179.8 16422.3 16503.9 16591.5 16596.3 900.3 903.1 926.4 928.3 929.1 914.1 914.8 914.9 917.0 922.2 955.5 957.4 957.7 958.8 959.2 944.7 947.6 949.2 949.8 951.4 692.6 697.0 697.5 699.0 699.4 17652.9 17660.0 17771.3 17780.8 17795.7 16794.7 16795.2 17131.1 17199.1 17399.2 12947.6 13337.3 13367.3 13549.2 13657.0 3998.3 4033.1 4047.0 4135.9 4138.8 90654.5 90769.0 91350.1 91702.5 94897.0 12482.3 12816.6 12853.7 13150.3 13373.8 23433.1 23451.8 23560.6 23725.6 24267.6 8331.7 9058.0 9136.5 9155.2 9193.8 5199.5 5251.5 5310.9 5334.0 5342.5 3851.2 3969.0 3989.4 3998.9 4005.0 678.7 689.4 765.2 806.6 811.8 756.7 798.3 832.7 853.0 854.7 10924.2 11374.9 11383.2 11493.3 11697.7 732.7 817.0 826.8 836.7 840.2 5235.4 5522.5 5602.5 5642.7 5663.6 69409.7 71156.6 125623.4 138530.0 140738.3 119474.0 119576.0 120757.0 121630.4 124802.4 88122.0 101052.5 101591.0 102281.0 105259.0 10344.8 10427.4 10458.4 10624.8 10625.3 58313.1 59753.7 59872.4 59966.7 61254.0 49496.5 81618.6 86169.1 86218.0 88641.6 13026.3 13260.9 13332.5 13424.1 13437.1 14665.9 15370.4 15539.0 15638.9 15705.7 13611.3 13658.9 13663.4 13851.0 13871.0 14163.2 14254.4 14769.0 15402.0 15414.5 14039.6 14669.9 14804.6 15057.9 15164.6 11738.4 11950.8 12367.9 12698.0 12798.1 10851.6 11000.0 11340.5 11545.1 12122.9 04:02:48 INFO - PROCESS | 9707 | -------- Summary: end -------- 04:02:48 INFO - PROCESS | 9707 | 04:02:49 INFO - TEST-INFO | 9707: exit 0 04:02:49 INFO - TEST-OK | dromaeo_css | took 1110966ms 04:02:49 INFO - TEST-START | kraken 04:02:49 INFO - operating with platform_type : linux_ 04:02:49 INFO - Initialising browser for kraken test... 04:02:49 INFO - TEST-INFO | started process 9968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5p7TRc/profile http://localhost:51696/getInfo.html) 04:02:54 INFO - PROCESS | 9968 | __metrics Screen width/height:1600/1200 04:02:54 INFO - PROCESS | 9968 | colorDepth:24 04:02:54 INFO - PROCESS | 9968 | Browser inner width/height: 1024/697 04:02:54 INFO - PROCESS | 9968 | __metrics 04:02:55 ERROR - PROCESS | 9968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:02:55 INFO - TEST-INFO | 9968: exit 0 04:02:55 INFO - Browser initialized. 04:02:55 INFO - Running cycle 1/1 for kraken test... 04:02:55 INFO - TEST-INFO | started process 10093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5p7TRc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:07 INFO - PROCESS | 10093 | RSS: Main: 153595904 04:03:07 INFO - PROCESS | 10093 | 04:03:10 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:10 INFO - PROCESS | 10093 | RSS: Main: 158978048 04:03:10 INFO - PROCESS | 10093 | 04:03:13 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-dft) 04:03:14 INFO - PROCESS | 10093 | RSS: Main: 157446144 04:03:14 INFO - PROCESS | 10093 | 04:03:17 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-fft) 04:03:17 INFO - PROCESS | 10093 | RSS: Main: 158547968 04:03:17 INFO - PROCESS | 10093 | 04:03:19 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51696/tests/kraken/driver.html?testName=audio-oscillator) 04:03:20 INFO - PROCESS | 10093 | RSS: Main: 157888512 04:03:20 INFO - PROCESS | 10093 | 04:03:22 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:23 INFO - PROCESS | 10093 | RSS: Main: 157884416 04:03:23 INFO - PROCESS | 10093 | 04:03:26 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:26 INFO - PROCESS | 10093 | RSS: Main: 158171136 04:03:26 INFO - PROCESS | 10093 | 04:03:30 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51696/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:30 INFO - PROCESS | 10093 | RSS: Main: 156225536 04:03:30 INFO - PROCESS | 10093 | 04:03:33 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51696/tests/kraken/driver.html?testName=json-parse-financial) 04:03:34 INFO - PROCESS | 10093 | RSS: Main: 157360128 04:03:34 INFO - PROCESS | 10093 | 04:03:35 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51696/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:36 INFO - PROCESS | 10093 | RSS: Main: 157024256 04:03:36 INFO - PROCESS | 10093 | 04:03:38 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:38 INFO - PROCESS | 10093 | RSS: Main: 157229056 04:03:38 INFO - PROCESS | 10093 | 04:03:40 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:41 INFO - PROCESS | 10093 | RSS: Main: 158314496 04:03:41 INFO - PROCESS | 10093 | 04:03:44 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:44 INFO - PROCESS | 10093 | RSS: Main: 158330880 04:03:44 INFO - PROCESS | 10093 | 04:03:47 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:48 INFO - PROCESS | 10093 | RSS: Main: 158351360 04:03:48 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | Cycle 1(1): loaded http://localhost:51696/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51696/tests/kraken/driver.html?testName=ai-astar) 04:03:49 INFO - PROCESS | 10093 | RSS: Main: 160612352 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | __start_tp_report 04:03:49 INFO - PROCESS | 10093 | _x_x_mozilla_page_load 04:03:49 INFO - PROCESS | 10093 | _x_x_mozilla_page_load_details 04:03:49 INFO - PROCESS | 10093 | |i|pagename|runs| 04:03:49 INFO - PROCESS | 10093 | |0;ai-astar;102;111;111;105;111;110;109;110;109;120 04:03:49 INFO - PROCESS | 10093 | |1;audio-beat-detection;150;115;147;165;118;145;149;124;182;117 04:03:49 INFO - PROCESS | 10093 | |2;audio-dft;162;162;163;166;162;161;162;164;161;160 04:03:49 INFO - PROCESS | 10093 | |3;audio-fft;74;77;75;177;84;76;77;76;160;76 04:03:49 INFO - PROCESS | 10093 | |4;audio-oscillator;84;82;139;83;84;83;146;83;84;133 04:03:49 INFO - PROCESS | 10093 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;119 04:03:49 INFO - PROCESS | 10093 | |6;imaging-darkroom;146;148;147;147;147;147;146;147;146;147 04:03:49 INFO - PROCESS | 10093 | |7;imaging-desaturate;95;95;97;95;95;95;95;95;96;95 04:03:49 INFO - PROCESS | 10093 | |8;json-parse-financial;52;52;51;52;55;53;51;53;52;52 04:03:49 INFO - PROCESS | 10093 | |9;json-stringify-tinderbox;60;60;63;58;60;59;59;59;59;60 04:03:49 INFO - PROCESS | 10093 | |10;stanford-crypto-aes;74;73;72;73;71;72;75;73;81;81 04:03:49 INFO - PROCESS | 10093 | |11;stanford-crypto-ccm;131;118;123;124;128;124;120;129;153;121 04:03:49 INFO - PROCESS | 10093 | |12;stanford-crypto-pbkdf2;153;150;151;152;152;149;153;162;150;152 04:03:49 INFO - PROCESS | 10093 | |13;stanford-crypto-sha256-iterative;63;62;63;62;66;61;61;60;61;61 04:03:49 INFO - PROCESS | 10093 | __end_tp_report 04:03:49 INFO - PROCESS | 10093 | __start_cc_report 04:03:49 INFO - PROCESS | 10093 | _x_x_mozilla_cycle_collect,865 04:03:49 INFO - PROCESS | 10093 | __end_cc_report 04:03:49 INFO - PROCESS | 10093 | __startTimestamp1473591829959__endTimestamp 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | ------- Summary: start ------- 04:03:49 INFO - PROCESS | 10093 | Number of tests: 14 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:4.64 (4.2%) stddev-sans-first:3.97 04:03:49 INFO - PROCESS | 10093 | Values: 102.0 111.0 111.0 105.0 111.0 110.0 109.0 110.0 109.0 120.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:148.00 stddev:22.42 (15.1%) stddev-sans-first:23.55 04:03:49 INFO - PROCESS | 10093 | Values: 150.0 115.0 147.0 165.0 118.0 145.0 149.0 124.0 182.0 117.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.70 (1.1%) stddev-sans-first:1.80 04:03:49 INFO - PROCESS | 10093 | Values: 162.0 162.0 163.0 166.0 162.0 161.0 162.0 164.0 161.0 160.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:38.93 (51.2%) stddev-sans-first:40.53 04:03:49 INFO - PROCESS | 10093 | Values: 74.0 77.0 75.0 177.0 84.0 76.0 77.0 76.0 160.0 76.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:83.00 stddev:27.25 (32.8%) stddev-sans-first:28.28 04:03:49 INFO - PROCESS | 10093 | Values: 84.0 82.0 139.0 83.0 84.0 83.0 146.0 83.0 84.0 133.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:03:49 INFO - PROCESS | 10093 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 119.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:03:49 INFO - PROCESS | 10093 | Values: 146.0 148.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:03:49 INFO - PROCESS | 10093 | Values: 95.0 95.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:1.22 04:03:49 INFO - PROCESS | 10093 | Values: 52.0 52.0 51.0 52.0 55.0 53.0 51.0 53.0 52.0 52.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:1.34 (2.2%) stddev-sans-first:1.41 04:03:49 INFO - PROCESS | 10093 | Values: 60.0 60.0 63.0 58.0 60.0 59.0 59.0 59.0 59.0 60.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:73.50 stddev:3.60 (4.9%) stddev-sans-first:3.81 04:03:49 INFO - PROCESS | 10093 | Values: 74.0 73.0 72.0 73.0 71.0 72.0 75.0 73.0 81.0 81.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:126.00 stddev:9.98 (7.9%) stddev-sans-first:10.49 04:03:49 INFO - PROCESS | 10093 | Values: 131.0 118.0 123.0 124.0 128.0 124.0 120.0 129.0 153.0 121.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:152.00 stddev:3.63 (2.4%) stddev-sans-first:3.84 04:03:49 INFO - PROCESS | 10093 | Values: 153.0 150.0 151.0 152.0 152.0 149.0 153.0 162.0 150.0 152.0 04:03:49 INFO - PROCESS | 10093 | 04:03:49 INFO - PROCESS | 10093 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.76 04:03:49 INFO - PROCESS | 10093 | Values: 63.0 62.0 63.0 62.0 66.0 61.0 61.0 60.0 61.0 61.0 04:03:49 INFO - PROCESS | 10093 | -------- Summary: end -------- 04:03:49 INFO - PROCESS | 10093 | 04:03:50 INFO - TEST-INFO | 10093: exit 0 04:03:50 INFO - TEST-OK | kraken | took 61404ms 04:03:50 INFO - SUITE-END | took 1172s 04:03:51 INFO - Completed test suite (00:19:32) 04:03:51 INFO - javascript benchmark 04:03:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7817.09759937089, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.4231259529583, 3311.12255252358, 3323.036319467353, 3323.202431416459, 3334.099793055875, 5656.57575681824, 5712.086066229404, 5748.885022299557, 5789.710514474281, 5799.797007104752, 5779.82660520184, 5808.883822323562, 5834.095715164156, 5851.2100866383025, 5857.8828423431505, 5222.608304377178, 5285.947140528603, 5290.365156181264, 5363.2491451196665, 5365.141577347626, 5202.193659982709, 5203.739813009353, 5224.216367544861, 5277.340332458442, 5305.840824775243, 5325.4940780625975, 5328.280682107924, 5335.493128152839, 5344.22508736233, 5400.891982160354, 5373.892522149574, 5382.838514844541, 5385.865353366197, 5394.946050539484, 5408.648437851527, 5033.345665063518, 5162.896742065138, 5179.8446046618665, 5275.129603615399, 5299.54953828925, 5165.560927321182, 5704.600677952545, 5720.256366672306, 5766.769329226826, 5833.095870140135, 6195.44241018306, 6237.157983672191, 6238.033104868752, 6249.343818899041, 6253.437190652818, 6044.2746870375395, 6235.158253635746, 6276.403741644536, 6278.843028924268, 6280.717367718464, 5689.374168841424, 5749.511291540182, 5751.1085781703905, 5802.593818432669, 5848.444397782204, 6239.06414037898, 6288.056791481315, 6327.4938004959495, 6328.082428047907, 6330.493560515148, 5917.704114794243, 6092.695365231721, 6103.054026625791, 6116.602420842631, 6132.908006379907, 6108.236470441195, 6177.104319873593, 6194.349593292639, 6300.149479820166, 6311.589746666452, 6204.5967012144065, 6243.125962365272, 6263.248410190715, 6266.749330026748, 6268.279147897959, 6017.729202185825, 6255.311915689271, 6276.372362763687, 6286.057091436322, 6289.842753931097, 4703.270992996091, 4726.503717109723, 4750.026244619845, 4775.450823155312, 4811.591014763784, 4232.851850185229, 4242.4272723181975, 4245.893852653709, 4251.17102165081, 4261.488621365394, 5679.403662615448, 5942.405759424109, 6000.5799594028, 6006.399360064046, 6017.608855424383, 6162.168107305546, 6168.506519478431, 6194.535409844189, 6299.559030867887, 6326.9683651581445, 5924.111383292455, 5973.701314934236, 5975.52195824333, 5979.730912108966, 6017.157597936292, 5231.555317797954, 5400.0, 5408.161734931092, 5409.323834520685, 5412.5940554458575, 6291.0, 6328.905066424008, 6384.297727249998, 6480.805575832733, 6487.578307410004, 6251.187345645037, 6288.717007734572, 6298.84252893663, 6301.0, 6307.90538141919, 6139.26328840542, 6421.101045853491, 6473.061406096184, 6482.70827812759, 6486.610803351814, 6035.6076855004285, 6075.939240607714, 6079.240094988127, 6147.016477363601, 6173.938260617337, 6242.344553821783, 6252.437280644764, 6256.0, 6267.059941008885, 6282.0, 6126.693665316628, 6136.907946380898, 6145.139680444652, 6147.66187859672, 6158.076288556752, 5848.239728835224, 5980.282366116094, 5998.0, 6058.091286307089, 6108.979583722478, 5951.523878089829, 6004.579679422399, 6016.729247183975, 6021.698915054142, 6068.8786224276155, 6067.54493412987, 6081.5134789217645, 6110.938890611037, 6119.173911521888, 6119.204503414528, 5817.7963771267805, 5847.1229315601295, 5915.674637894785, 5924.674142922008, 5996.340402555628], "value": 5724.472687195396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9469947704706, 643.2795269298387, 659.3604203922197, 666.187251553105, 666.8366250268685, 35192.0, 46356.304655430155, 47309.29036064462, 47338.053238935245, 47609.52390476094, 49152.26271605929, 49471.25793113106, 49498.50501494984, 49749.25376119361, 49751.25373119406, 9194.724158275245, 9296.349255552113, 9319.62721491143, 9336.906630933705, 9338.906610933906, 9029.142231487998, 9097.63609455621, 9157.816843663122, 9196.908030919705, 9211.078892110801, 9169.862452063224, 9261.0, 9262.351635385527, 9270.860937085916, 9303.627854885797, 9173.816523669557, 9226.584803683816, 9262.027487113857, 9280.90719092814, 9287.349885508018, 9205.0, 9301.976782553913, 9306.953465232698, 9309.208717258973, 9311.02234265406, 46790.53209467896, 46856.0, 47258.76370618159, 47264.7636761814, 47383.76308118437, 3780.3573392523335, 3859.3439115350457, 3946.842126314944, 3954.8418063277436, 3973.4238535412205, 31850.681493185235, 32189.83905080483, 32234.194145146324, 34920.0, 37081.25837483235, 4499.662525310615, 4502.189605870942, 4510.323451482304, 4519.909601807978, 4596.4254468191475, 383785.0, 387529.0, 387540.0, 389732.0, 390345.0, 38631.42052869209, 39904.201915961516, 64957.0, 65110.67444662746, 65128.0, 41561.58438415638, 41950.0, 42088.158236835094, 42103.15793684109, 42107.15785684269, 17720.20259088344, 17728.0, 17757.0, 17802.0, 17860.55348616295, 15027.474038408604, 15098.54704358849, 15118.395264189308, 15165.924170379298, 15176.165310907785, 9244.583993720298, 9248.398854074463, 9291.814163716688, 9378.249740020781, 9435.0, 3541.94687079694, 3571.8571257149943, 3587.587427445877, 3597.172650290448, 3607.6211997740384, 1082.653550863716, 1104.276698762312, 1120.506976930148, 1186.9347185904685, 1216.1183142221996, 35119.4732079019, 35452.468212976826, 35522.11194720153, 35695.10762230913, 35755.46366804448, 1239.2812168941991, 1255.4350542256022, 1286.6847622332402, 1289.1362786932777, 1324.2857071735432, 17823.73264401035, 18304.0, 18324.267029318944, 18776.71834922477, 18948.43154705361, 603602.0, 606026.0, 609311.0, 614115.0, 618106.0, 66746.0, 67053.0, 67131.0, 67285.0, 67368.32631673719, 1440.0855456784807, 1453.0700351774872, 1463.5828788795143, 1504.5787179589731, 1520.361448191762, 34036.659633403346, 34063.829680851435, 34441.48337774986, 34460.82769586136, 34660.82669586636, 57582.136267956856, 58106.7094664524, 58163.70918145382, 58173.127403089835, 58345.12482312684, 511968.0, 513070.0, 513428.0, 514925.0, 515136.0, 31550.684493154775, 31632.0, 31752.0, 31945.6805431952, 32103.67896321007, 53744.731276343366, 54153.45846541642, 54408.727956359966, 54592.181117282475, 55178.72410637921, 46041.30938035999, 46373.304400434696, 46785.53214467948, 47749.0, 48663.02673946572, 46351.76824115858, 46585.767071164424, 47245.76377118092, 47332.0, 47718.761406194135, 45257.77371113123, 45771.77114114408, 46744.0, 46746.76626616845, 46860.53139468562, 38644.420333694456, 40462.19075618412, 40735.0, 41117.177656447304, 41607.37588936108, 31088.22279443032, 31197.844010780707, 31332.0, 31414.214644634067, 31584.0], "value": 20814.64168337667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.1303263147391, 416.35257175092755, 428.07322147550553, 434.72829481574024, 435.85398891371386, 19872.503187420305, 20929.37211883642, 21512.784872151275, 21564.784352156512, 21641.242556510526, 20554.280600178998, 20577.27979520717, 20706.585868282662, 20944.685829712565, 21158.894205528988, 5624.437556244374, 5919.940800591982, 5922.733476993524, 5932.37710040446, 5943.0, 5628.409017053192, 5770.769169233246, 5800.506956908646, 5807.419258074201, 5826.242588463494, 5728.484436400723, 5765.250517432728, 5766.9711651441685, 5799.565032622549, 5801.767929282844, 5606.383297837235, 5823.708814559276, 5907.1434641976675, 5910.4089591040765, 5921.61509501881, 5254.106801843695, 5270.7628156733035, 5285.577153827723, 5294.126469132627, 5306.204069389622, 24524.264272071865, 25004.624930626054, 25012.249632511055, 25043.749562504323, 25085.4982900341, 2534.6451496790464, 2548.3119557719497, 2588.1459118491043, 2764.5853122031654, 3105.6117985251844, 15571.299291531908, 15777.921110394489, 15786.131762753044, 16109.83890161095, 16620.50138495835, 1989.7910719374402, 2008.3673642802617, 2017.2536161620149, 2017.778044415113, 2114.4185349028985, 57232.6700468288, 83836.74244886392, 84347.0, 85410.14589854084, 87708.56145719295, 11544.365059921616, 11700.824487632692, 11721.179517433868, 12045.819312710317, 12411.069169812301, 16383.59041023984, 16396.344146234016, 16428.917855410884, 16434.83565164333, 16485.58786030359, 8698.433002878162, 8964.551772411354, 9088.772780680403, 9221.308401869886, 9223.077692230723, 8931.955340223258, 9014.684486043088, 9040.0, 9177.77055573616, 9250.398724083048, 7121.9643901780155, 7165.140183178052, 7221.205667376585, 7308.96345518269, 7328.3404493595835, 1999.3402177281462, 2035.1452389996236, 2064.886431246296, 2092.7174831397565, 2106.24175296893, 1026.5483187397522, 1067.1942683274078, 1076.5586109694987, 1083.6369816111533, 1101.6915263726169, 21096.78903210979, 21219.68170477444, 21449.785502145092, 21620.736698499317, 21667.133314667553, 1046.9685909422728, 1068.3536460441476, 1069.4652673663168, 1095.7205912492263, 1124.8312753087102, 11295.661130166109, 12301.0, 12450.128491005724, 12477.31374774378, 12560.371981401076, 529336.0, 534042.0, 551205.0, 561133.0, 562598.0, 82456.0, 83131.5843420779, 84027.0, 84737.0, 85129.0, 1073.3988966178808, 1084.983725244122, 1104.9779004419865, 1112.0491979357532, 1117.0337657925836, 18705.53236169107, 18896.0, 18966.905165474636, 19071.427857164308, 19144.0, 41280.0, 41432.1713565721, 41472.79263603783, 41542.0, 42664.0, 54584.0, 55381.0, 55632.0, 57230.71384643217, 57275.42724572701, 8843.0, 8878.822423551623, 8962.32782541299, 9022.819543608959, 9260.0, 8514.680224565202, 8914.86627700572, 13327.200367977952, 13483.730325393633, 13507.864921350661, 10809.405482698527, 10851.837222441827, 11104.777904441704, 11172.49723762449, 11533.192676512563, 11412.201145919706, 11613.593524226611, 12113.15207935436, 12139.939300303442, 12171.2697238166, 6078.54410919174, 10513.053825155772, 11483.483243253906, 12049.51801927913, 12411.379431028232, 8761.211490965843, 8854.070322616033, 8921.643134274816, 9144.58849351794, 9240.260779137518, 11478.827817582576, 11805.23265987708, 11860.584879529175, 12272.202306850026, 12432.12975091735], "value": 9805.561080767788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.2345562402236, 1578.3686525389842, 1765.887490880745, 1867.113121267399, 1889.971650425243, 8630.180132887366, 9219.907800921988, 9298.0, 9928.0, 9949.353292036012, 9296.535173241346, 9642.2768292378, 9671.468069256189, 9686.66096686616, 9718.173955213797, 2508.3729067733066, 2544.0586982816385, 2548.4138648110948, 2550.681164854393, 2553.706323772762, 2501.2746303571944, 2539.885705143273, 2550.0947163756878, 2553.9361515962155, 2563.8333508321994, 2460.5817011108156, 2463.5319289335057, 2475.504899020194, 2503.7120731115883, 2504.2362079565723, 2406.1578447543307, 2420.1892366057305, 2429.441228517442, 2476.26950049734, 2478.491909158618, 2397.0651445935923, 2414.4446777241155, 2419.552382809186, 2424.187897054489, 2452.3869032741813, 9615.086566776215, 9686.806263874683, 9707.70876873695, 9734.805303893883, 9744.853827192597, 5745.310562732457, 5771.740271687784, 5867.471927526543, 5886.7939622113445, 5911.29064512257, 3632.0556655269556, 3670.137517683342, 3717.5910649828766, 3731.7574357666663, 3811.7141214408753, 1196.3539688568162, 1207.7161866961258, 1219.1222319929636, 1219.9085068619888, 1243.4280231093708, 13954.302284885816, 13967.0, 14055.0, 14088.647783805385, 14096.0, 4960.826371076995, 5045.394552653705, 5137.563307118862, 5185.974070129625, 5205.297284866495, 11633.41832908368, 11692.532298708127, 11712.648620541397, 11718.70703232426, 11774.0, 5828.417158284137, 5828.737706803204, 5859.794907178229, 5870.119482077723, 5870.442307980735, 4530.320451932236, 5292.206169074592, 5370.087085195526, 5404.891902161935, 5550.028744969614, 4416.359627854007, 4461.933071003873, 4468.173387923244, 4500.797464114123, 4519.209138400766, 1345.8990575706862, 1391.4156054457153, 1397.1407584335561, 1404.3189053309136, 1418.666613345863, 1058.3438268273567, 1060.692399204222, 1065.3394895165047, 1065.840123981409, 1082.8862969388258, 6316.968415157895, 6422.229332480132, 6569.343065693488, 6678.899816502756, 6782.118324617768, 1022.2588623248234, 1029.8455231715302, 1040.891450605103, 1054.9103326217205, 1073.3452593917705, 4381.583749543788, 4383.473983122046, 4470.709403888737, 4584.770761461914, 4650.930236046462, 12073.33596652175, 12268.202566833128, 12472.875271247352, 12484.500619975099, 12494.25034497915, 12305.384730763426, 12345.691357716129, 12387.380630968415, 12415.0, 12434.129610927148, 8692.652293908173, 8859.734207973772, 8865.955670221736, 8940.105989401138, 9037.50293733851, 6666.699998500176, 6795.354441328066, 6820.863582728417, 6862.176538815174, 6933.583984960918, 10866.348019118877, 11228.10175185967, 11416.372099534605, 11514.078873689918, 11528.250663706833, 11079.446027698421, 11247.212695111264, 11405.258658187191, 11431.828522572001, 11582.88417115818, 8201.671933122609, 8394.622241999003, 8452.661893524437, 8654.134586541295, 8695.826083478421, 9743.707688769347, 9789.559469824018, 9791.314607977372, 9851.162651174443, 9853.901460985586, 8602.18279263469, 8625.827483450421, 8725.781855453664, 8754.737357879274, 8817.559122044, 8265.256126948603, 8348.749537513884, 8485.490870547786, 8560.186782255676, 8634.870476942977, 7736.458447908817, 7856.7250146244605, 7865.213478652089, 7876.291133797986, 7889.566073865993, 5673.375928647928, 5770.711464426678, 5840.240768700211, 5850.327212370632, 5924.200232968494, 5739.282589676291, 5792.333881603501, 5801.419858014165, 5859.619124756877, 5966.075258334965], "value": 5137.543432815877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.8116417134747, 356.4403885899139, 358.369270084651, 360.814180696941, 362.84760400631717, 5655.3779084300695, 5712.97166510028, 5865.1202319652075, 5870.148828419882, 5924.074675730389, 5707.6290041147295, 5748.2527271454655, 5756.654600723959, 5756.683382413966, 5761.539076873851, 4480.731156130626, 4482.439695038121, 4518.638508919295, 4530.003399252176, 4532.0, 4443.22243607369, 4504.527024662412, 4512.052468981517, 4516.932246016296, 4535.841245556406, 4458.687891847572, 4464.285714285715, 4469.44131983502, 4479.910401791978, 4503.639708823286, 4471.4857791353925, 4486.416765820439, 4489.416375871148, 4507.977460112711, 4521.660875434355, 3840.711946603988, 3907.27715372657, 3909.257241124177, 3926.489556357684, 3933.115049113955, 5586.832395028156, 5603.915941260884, 5645.266115405012, 5645.604807663465, 5700.23046888673, 5000.499950005007, 5133.383993920716, 5162.0, 5175.974120129413, 5185.481451854822, 5929.399062253167, 6003.759849606011, 6003.969980150115, 6009.1587177795145, 6012.819615411545, 4316.287812510932, 4331.242032644306, 4352.064306174188, 4356.869293921188, 4369.825206991716, 5991.910121348184, 6197.287311959138, 6293.496520278367, 6322.683865806691, 6350.618962862243, 4384.0, 4417.425734654475, 4444.355568442623, 4450.5549445055885, 4466.39703640011, 4461.687681862303, 4502.851772797915, 4502.864914052584, 4520.547945205453, 4537.115262523776, 4947.307376967227, 5105.770240339194, 5161.354830646169, 5170.80240897617, 5184.196449550326, 5876.647401155944, 6051.425114614105, 6058.1518587397795, 6072.574919755663, 6078.939210607926, 1520.9619759506102, 1546.8685161761377, 1565.0844256110076, 1569.7834178511516, 1571.9921400393152, 952.1668540027476, 979.7501637082498, 980.3970558106713, 989.0, 993.339429279521, 5170.379554453414, 5230.320058392384, 5251.6061295403, 5259.552938000313, 5295.391030031518, 5506.284183056177, 5529.783447641513, 5538.175530479404, 5549.72251387429, 5555.611107222537, 5079.238114282887, 5187.974060129675, 5225.5819534437915, 5241.633085684041, 5261.657992230493, 2940.9852950735108, 2942.4997750382486, 2946.351802603424, 2946.3942151527467, 2951.4539810135193, 5669.43305669438, 5685.6304340218585, 5711.685857277889, 5712.971435142797, 5718.884817460638, 5200.531952124251, 5540.612157148961, 5628.831135065954, 5635.351934527582, 5645.407232240637, 5695.772169113189, 5752.194692743019, 5757.0, 5767.702266989978, 5778.855528611734, 5536.031194540858, 5566.387697353207, 5593.300837395325, 6021.7591296347655, 6280.591761535486, 6208.689565521796, 6211.0, 6216.285127210429, 6220.0, 6233.781817636361, 6309.274433440213, 6450.870982580416, 6502.544821862613, 6524.510661700297, 6529.183852018497, 4281.666491761935, 4332.241857674957, 4346.500152482505, 4356.237658409829, 4363.105563359567, 6058.939685555099, 6102.176206212104, 6331.860265152317, 6348.206474190726, 6354.538456155018, 6072.726727297194, 6096.817095487142, 6155.983568051712, 6161.44546990773, 6167.691615419121, 6117.0, 6120.693965301806, 6134.325224225242, 6135.9386406137155, 6148.723307451086, 5811.302643682785, 6054.576179667557, 6063.848403789941, 6083.239595050619, 6083.908741368795, 6178.969105154445, 6180.165677633642, 6201.0, 6241.687915604292, 6251.124842522141, 5848.64908105515, 5923.466887980103, 5935.792247271324, 5984.970075149597, 6022.2171117754415], "value": 4510.130421588238, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [858.5492616376406, 862.8533149364607, 870.6386849457474, 893.6470094312747, 948.3314263444264, 16204.351825926964, 17984.910075449636, 18064.27742890286, 18111.90944045281, 18238.361657341997, 16179.83820161798, 16422.26099825508, 16503.917480412612, 16591.502254932373, 16596.25316860741, 900.3427497926501, 903.1284810158229, 926.3978414030901, 928.3037721708719, 929.0848514213494, 914.1270087066869, 914.8399030169727, 914.862770584411, 916.9633214671405, 922.1792604581927, 955.4697143085584, 957.3681370295607, 957.6504575829841, 958.8178246133248, 959.1559427703611, 944.6552008516876, 947.6162154327509, 949.2026697574037, 949.8195342884865, 951.3578334624101, 692.5879101934341, 696.9930300696979, 697.4594689115925, 698.9685464154126, 699.4124935054527, 17652.91173544137, 17660.02869842158, 17771.289148434047, 17780.822191778174, 17795.73306400405, 16794.748078778826, 16795.16024198785, 17131.14344282793, 17199.140042997926, 17399.173086825955, 12947.611571652866, 13337.333133343294, 13367.264800435973, 13549.187048777105, 13657.0, 3998.300297447964, 4033.1127152026506, 4047.028713108862, 4135.875923722293, 4138.8344466221315, 90654.5467272666, 90769.0, 91350.08649913482, 91702.54148729214, 94896.99999999932, 12482.251064936132, 12816.615501534969, 12853.742925141445, 13150.276734779487, 13373.799393009112, 23433.06267749305, 23451.765482345298, 23560.64659030116, 23725.644115338284, 24267.63598546023, 8331.6667333306, 9058.0, 9136.543172841331, 9155.221806146552, 9193.816123677489, 5199.454057324002, 5251.501107394792, 5310.92033619496, 5334.013207556614, 5342.465753424704, 3851.1527463957887, 3968.9603103969166, 3989.3617021277037, 3998.900027499336, 4005.0387906902715, 678.6945874356559, 689.427774946793, 765.2462324610254, 806.5604245685997, 811.8416908702865, 756.7200135949623, 798.3014861995754, 832.7376876283951, 853.0, 854.6837670061992, 10924.235303528836, 11374.886251137548, 11383.215661263936, 11493.310401375944, 11697.707557311136, 732.7179036071044, 816.9918300817035, 826.8181000179951, 836.6695155413578, 840.2060053249743, 5235.397929238186, 5522.487761592809, 5602.52378547828, 5642.689652069175, 5663.575231857545, 69409.65295173491, 71156.64421677962, 125623.37188314182, 138530.0, 140738.2963085178, 119474.0, 119576.0, 120757.0, 121630.39184804019, 124802.37598812129, 88122.0, 101052.49473752732, 101591.0, 102281.0, 105259.0, 10344.810346809913, 10427.426491543038, 10458.372497650165, 10624.787504249716, 10625.309354891908, 58313.125303121335, 59753.701231493564, 59872.40127598668, 59966.700166498886, 61254.0, 49496.50503494919, 81618.59190704009, 86169.13830861611, 86218.0, 88641.55679221563, 13026.2835544046, 13260.867391326348, 13332.533361332307, 13424.127431716906, 13437.126586771828, 14665.92667036658, 15370.385184592491, 15539.0, 15638.9218053909, 15705.68588628244, 13611.31943402806, 13658.863411365759, 13663.385147668578, 13851.0, 13871.0, 14163.150210987375, 14254.358553864893, 14769.0, 15402.0, 15414.46049388266, 14039.578812635636, 14669.853301466848, 14804.62988425298, 15057.924710376377, 15164.620884477976, 11738.390806877762, 11950.760984780429, 12367.876321236672, 12698.0, 12798.104132710621, 10851.565937362733, 11000.0, 11340.489677964346, 11545.13411494158, 12122.878771212176], "value": 8427.750982821422, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 105.0, 111.0, 110.0, 109.0, 110.0, 109.0, 120.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 147.0, 165.0, 118.0, 145.0, 149.0, 124.0, 182.0, 117.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 166.0, 162.0, 161.0, 162.0, 164.0, 161.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 177.0, 84.0, 76.0, 77.0, 76.0, 160.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 139.0, 83.0, 84.0, 83.0, 146.0, 83.0, 84.0, 133.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 55.0, 53.0, 51.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 63.0, 58.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 71.0, 72.0, 75.0, 73.0, 81.0, 81.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 118.0, 123.0, 124.0, 128.0, 124.0, 120.0, 129.0, 153.0, 121.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 151.0, 152.0, 152.0, 149.0, 153.0, 162.0, 150.0, 152.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 66.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 62.0, "unit": "score"}]}]} 04:03:51 INFO - Return code: 0 04:03:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:03:51 ERROR - # TBPL SUCCESS # 04:03:51 INFO - Running post-action listener: _resource_record_post_action 04:03:51 INFO - [mozharness: 2016-09-11 11:03:51.276919Z] Finished run-tests step (success) 04:03:51 INFO - Running post-run listener: _resource_record_post_run 04:03:51 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 325857280; Read time: 32; Write time: 325128 04:03:51 INFO - TinderboxPrint: CPU usage
13.3% 04:03:51 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 04:03:51 INFO - TinderboxPrint: I/O write bytes / time
325,857,280 / 325,128 04:03:51 INFO - TinderboxPrint: CPU idle
8,234.1 (86.7%) 04:03:51 INFO - TinderboxPrint: CPU user
1,202.1 (12.7%) 04:03:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:03:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78655488; Read time: 0; Write time: 59492 04:03:51 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246136832; Read time: 20; Write time: 265492 04:03:51 INFO - Running post-run listener: _upload_blobber_files 04:03:51 INFO - Blob upload gear active. 04:03:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:51 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 04:03:51 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'] 04:03:51 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 04:03:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:53 INFO - (blobuploader) - INFO - Done attempting. 04:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:03:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:54 INFO - (blobuploader) - INFO - Done attempting. 04:03:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:03:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:57 INFO - (blobuploader) - INFO - Done attempting. 04:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 04:03:57 INFO - Return code: 0 04:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f56a0703c164c71aa0f5c27415dd3f97203f4d25c1ecb30cfaeb5091f02ddeab788c68c236bde46e033e1e9ff7982f0da10d94808e7b3b5016d97e90f55890ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df3a6d5c1047af44b8e3b0e6dbf381a3b3e12458aa9fcc082e988f1e3ce51e88eabc49cefb65925517092837a67330b5154392cc1a75691ce8ef9a06082a2fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6501f40a17d8991a49744705e50889a5617a5dd477b83b53c1bcfd65b244a302a688f4016aa72c8b7b31edf0c7e9ada9d33230566655a7351583acd1c1ef6f08"} 04:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:03:57 INFO - Contents: 04:03:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f56a0703c164c71aa0f5c27415dd3f97203f4d25c1ecb30cfaeb5091f02ddeab788c68c236bde46e033e1e9ff7982f0da10d94808e7b3b5016d97e90f55890ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df3a6d5c1047af44b8e3b0e6dbf381a3b3e12458aa9fcc082e988f1e3ce51e88eabc49cefb65925517092837a67330b5154392cc1a75691ce8ef9a06082a2fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6501f40a17d8991a49744705e50889a5617a5dd477b83b53c1bcfd65b244a302a688f4016aa72c8b7b31edf0c7e9ada9d33230566655a7351583acd1c1ef6f08"} 04:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 04:03:57 INFO - Copying logs to upload dir... 04:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 04:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.818020 ========= master_lag: 35.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 32 secs) (at 2016-09-11 04:04:32.338874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 04:04:32.344103) ========= 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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 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/f56a0703c164c71aa0f5c27415dd3f97203f4d25c1ecb30cfaeb5091f02ddeab788c68c236bde46e033e1e9ff7982f0da10d94808e7b3b5016d97e90f55890ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df3a6d5c1047af44b8e3b0e6dbf381a3b3e12458aa9fcc082e988f1e3ce51e88eabc49cefb65925517092837a67330b5154392cc1a75691ce8ef9a06082a2fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6501f40a17d8991a49744705e50889a5617a5dd477b83b53c1bcfd65b244a302a688f4016aa72c8b7b31edf0c7e9ada9d33230566655a7351583acd1c1ef6f08"} build_url:https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/VfN27DBgTDClEKi7gifl_w/artifacts/public/build/firefox-50.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/f56a0703c164c71aa0f5c27415dd3f97203f4d25c1ecb30cfaeb5091f02ddeab788c68c236bde46e033e1e9ff7982f0da10d94808e7b3b5016d97e90f55890ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df3a6d5c1047af44b8e3b0e6dbf381a3b3e12458aa9fcc082e988f1e3ce51e88eabc49cefb65925517092837a67330b5154392cc1a75691ce8ef9a06082a2fe1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6501f40a17d8991a49744705e50889a5617a5dd477b83b53c1bcfd65b244a302a688f4016aa72c8b7b31edf0c7e9ada9d33230566655a7351583acd1c1ef6f08"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 04:04:32.547274) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 04:04:32.547681) ========= 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=920470bf432669ad7e3a5387000001ca-1473590157.814161-2050236107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 1.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 04:04:33.577690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 04:04:33.578070) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 04:04:33.581880) ========= ========= Total master_lag: 36.84 =========