builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1471427318.67 results: success (0) buildid: 20160817000116 builduid: 1b6e6293fa4245c58022415da2da6c45 revision: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:38.671060) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:38.671460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:38.671763) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:38.713021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:38.713317) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 02:48:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 40.8M=0s 2016-08-17 02:48:39 (40.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.308597 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.051606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.051878) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.107706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.108175) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 --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 fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 --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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 02:48:39,411 truncating revision to first 12 chars 2016-08-17 02:48:39,411 Setting DEBUG logging. 2016-08-17 02:48:39,411 attempt 1/10 2016-08-17 02:48:39,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fdc2f1d67e39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 02:48:39,720 unpacking tar archive at: mozilla-aurora-fdc2f1d67e39/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692154 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.815740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.816449) ========= script_repo_revision: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.817047) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.817308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 02:48:39.827207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-17 02:48:39.827579) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:48:40 INFO - MultiFileLogger online at 20160817 02:48:40 in /builds/slave/test 02:48:40 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 02:48:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:40 INFO - {'append_to_log': False, 02:48:40 INFO - 'base_work_dir': '/builds/slave/test', 02:48:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:40 INFO - 'branch': 'Mozilla-Aurora', 02:48:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:40 INFO - 'config_files': ('talos/linux_config.py',), 02:48:40 INFO - 'default_actions': ('clobber', 02:48:40 INFO - 'read-buildbot-config', 02:48:40 INFO - 'download-and-extract', 02:48:40 INFO - 'populate-webroot', 02:48:40 INFO - 'create-virtualenv', 02:48:40 INFO - 'install', 02:48:40 INFO - 'run-tests'), 02:48:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:40 INFO - 'download_minidump_stackwalk': True, 02:48:40 INFO - 'download_symbols': 'ondemand', 02:48:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:40 INFO - 'installer_path': 'installer.exe', 02:48:40 INFO - 'log_level': 'info', 02:48:40 INFO - 'log_name': 'talos', 02:48:40 INFO - 'log_to_console': True, 02:48:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:48:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:48:40 INFO - 'opt_config_files': (), 02:48:40 INFO - 'pip_index': False, 02:48:40 INFO - 'sps_profile': False, 02:48:40 INFO - 'sps_profile_interval': 0, 02:48:40 INFO - 'suite': 'dromaeojs-e10s', 02:48:40 INFO - 'system_bits': '32', 02:48:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:40 INFO - 'title': 'talos-linux64-ix-013', 02:48:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:40 INFO - 'use_talos_json': True, 02:48:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:40 INFO - 'work_dir': 'build'} 02:48:40 INFO - [mozharness: 2016-08-17 09:48:40.227019Z] Running clobber step. 02:48:40 INFO - Running pre-action listener: _resource_record_pre_action 02:48:40 INFO - Running main action method: clobber 02:48:40 INFO - rmtree: /builds/slave/test/build 02:48:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:40 INFO - Running post-action listener: _resource_record_post_action 02:48:40 INFO - [mozharness: 2016-08-17 09:48:40.684229Z] Finished clobber step (success) 02:48:40 INFO - [mozharness: 2016-08-17 09:48:40.684329Z] Running read-buildbot-config step. 02:48:40 INFO - Running pre-action listener: _resource_record_pre_action 02:48:40 INFO - Running main action method: read_buildbot_config 02:48:40 INFO - Using buildbot properties: 02:48:40 INFO - { 02:48:40 INFO - "project": "", 02:48:40 INFO - "product": "firefox", 02:48:40 INFO - "script_repo_revision": "production", 02:48:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:48:40 INFO - "repository": "", 02:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:48:40 INFO - "buildid": "20160817000116", 02:48:40 INFO - "pgo_build": "True", 02:48:40 INFO - "basedir": "/builds/slave/test", 02:48:40 INFO - "buildnumber": 503, 02:48:40 INFO - "slavename": "talos-linux64-ix-013", 02:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:48:40 INFO - "platform": "ubuntu64_hw", 02:48:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:48:40 INFO - "branch": "mozilla-aurora", 02:48:40 INFO - "repo_path": "releases/mozilla-aurora", 02:48:40 INFO - "revision": "fdc2f1d67e3977e4fbc79d0acbb32259eca0f524", 02:48:40 INFO - "stage_platform": "linux64-pgo", 02:48:40 INFO - "builduid": "1b6e6293fa4245c58022415da2da6c45", 02:48:40 INFO - "slavebuilddir": "test" 02:48:40 INFO - } 02:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 02:48:40 INFO - Running post-action listener: _resource_record_post_action 02:48:40 INFO - [mozharness: 2016-08-17 09:48:40.686771Z] Finished read-buildbot-config step (success) 02:48:40 INFO - [mozharness: 2016-08-17 09:48:40.686860Z] Running download-and-extract step. 02:48:40 INFO - Running pre-action listener: _resource_record_pre_action 02:48:40 INFO - Running main action method: download_and_extract 02:48:40 INFO - mkdir: /builds/slave/test/build/tests 02:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:48:40 INFO - https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:48:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:48:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:48:40 INFO - retry: Failed, sleeping 30 seconds before retrying 02:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:49:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:49:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:49:10 INFO - retry: Failed, sleeping 60 seconds before retrying 02:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:50:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:50:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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! 02:50:10 INFO - Caught exception: HTTP Error 404: Not Found 02:50:10 INFO - Caught exception: HTTP Error 404: Not Found 02:50:10 INFO - Caught exception: HTTP Error 404: Not Found 02:50:10 INFO - trying https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:50:10 INFO - Downloading https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:11 INFO - Downloaded 1361 bytes. 02:50:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 02:50:11 INFO - Using the following test package requirements: 02:50:11 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 02:50:11 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:50:11 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:50:11 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'jsshell-linux-x86_64.zip'], 02:50:11 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:50:11 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 02:50:11 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:50:11 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:50:11 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:50:11 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 02:50:11 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:50:11 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:50:11 INFO - https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:50:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:50:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:50:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:50:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:50:11 INFO - retry: Failed, sleeping 30 seconds before retrying 02:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:50:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:50:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:50:41 INFO - retry: Failed, sleeping 60 seconds before retrying 02:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:51:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:51:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:51:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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! 02:51:41 INFO - Caught exception: HTTP Error 404: Not Found 02:51:41 INFO - Caught exception: HTTP Error 404: Not Found 02:51:41 INFO - Caught exception: HTTP Error 404: Not Found 02:51:41 INFO - trying https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:51:41 INFO - Downloading https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:51:43 INFO - Downloaded 21767137 bytes. 02:51:43 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'] 02:51:43 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 02:51:44 INFO - Return code: 0 02:51:44 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 02:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:44 INFO - https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:51:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:51:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:51:44 INFO - retry: Failed, sleeping 30 seconds before retrying 02:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:52:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:52:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:52:14 INFO - retry: Failed, sleeping 60 seconds before retrying 02:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:53:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:53:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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! 02:53:14 INFO - Caught exception: HTTP Error 404: Not Found 02:53:14 INFO - Caught exception: HTTP Error 404: Not Found 02:53:14 INFO - Caught exception: HTTP Error 404: Not Found 02:53:14 INFO - trying https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 02:53:14 INFO - Downloading https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:15 INFO - Downloaded 21767137 bytes. 02:53:15 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'] 02:53:15 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 02:53:17 INFO - Return code: 0 02:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:17 INFO - https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:53:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:53:17 INFO - retry: Failed, sleeping 30 seconds before retrying 02:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:53:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:53:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:53:47 INFO - retry: Failed, sleeping 60 seconds before retrying 02:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:54:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:54:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:54:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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! 02:54:47 INFO - Caught exception: HTTP Error 404: Not Found 02:54:47 INFO - Caught exception: HTTP Error 404: Not Found 02:54:47 INFO - Caught exception: HTTP Error 404: Not Found 02:54:47 INFO - trying https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 02:54:47 INFO - Downloading https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:54:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:54:48 INFO - Downloaded 14413723 bytes. 02:54:48 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'] 02:54:48 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 02:54:48 INFO - Return code: 0 02:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:48 INFO - https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:54:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:54:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 02:54:48 INFO - retry: Failed, sleeping 30 seconds before retrying 02:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:55:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:55:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 02:55:18 INFO - retry: Failed, sleeping 60 seconds before retrying 02:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:56:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:56:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 02:56:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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! 02:56:18 INFO - Caught exception: HTTP Error 404: Not Found 02:56:18 INFO - Caught exception: HTTP Error 404: Not Found 02:56:18 INFO - Caught exception: HTTP Error 404: Not Found 02:56:18 INFO - trying https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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 02:56:20 INFO - Downloaded 63782847 bytes. 02:56:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:56:20 INFO - mkdir: /builds/slave/test/properties 02:56:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:56:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:56:20 INFO - Contents: 02:56:20 INFO - build_url:https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 02:56:20 INFO - Running post-action listener: _resource_record_post_action 02:56:20 INFO - Running post-action listener: set_extra_try_arguments 02:56:20 INFO - [mozharness: 2016-08-17 09:56:20.919486Z] Finished download-and-extract step (success) 02:56:20 INFO - [mozharness: 2016-08-17 09:56:20.919727Z] Running populate-webroot step. 02:56:20 INFO - Running pre-action listener: _resource_record_pre_action 02:56:20 INFO - Running main action method: populate_webroot 02:56:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:56:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:56:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:56:20 INFO - '--tppagecycles', 02:56:20 INFO - '7'], 02:56:20 INFO - 'tests': ['tsvgm']}}, 02:56:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:56:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:56:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:56:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:56:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['damp', 'tps']}, 02:56:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'tests': ['damp', 'tps']}, 02:56:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['dromaeo_dom']}, 02:56:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:56:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['basic_compositor_video']}, 02:56:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:56:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['a11yr', 02:56:20 INFO - 'ts_paint', 02:56:20 INFO - 'tpaint', 02:56:20 INFO - 'sessionrestore', 02:56:20 INFO - 'sessionrestore_no_auto_restore', 02:56:20 INFO - 'tabpaint']}, 02:56:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['tsvgx', 02:56:20 INFO - 'tsvgr_opacity', 02:56:20 INFO - 'tart', 02:56:20 INFO - 'tscrollx', 02:56:20 INFO - 'cart']}, 02:56:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:56:20 INFO - 'tsvgr_opacity', 02:56:20 INFO - 'tart', 02:56:20 INFO - 'tscrollx', 02:56:20 INFO - 'cart']}, 02:56:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'talos_options': ['--disable-e10s'], 02:56:20 INFO - 'tests': ['tp5o']}, 02:56:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'tests': ['tp5o']}, 02:56:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'talos_options': ['--disable-e10s', 02:56:20 INFO - '--xperf_path', 02:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:20 INFO - 'tests': ['tp5n']}, 02:56:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:20 INFO - 'talos_options': ['--xperf_path', 02:56:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:20 INFO - 'tests': ['tp5n']}}, 02:56:20 INFO - 'talos.zip': {'path': '', 02:56:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:56:20 INFO - Running post-action listener: _resource_record_post_action 02:56:20 INFO - [mozharness: 2016-08-17 09:56:20.940527Z] Finished populate-webroot step (success) 02:56:20 INFO - [mozharness: 2016-08-17 09:56:20.940616Z] Running create-virtualenv step. 02:56:20 INFO - Running pre-action listener: _resource_record_pre_action 02:56:20 INFO - Running main action method: create_virtualenv 02:56:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:56:20 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 02:56:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:56:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:56:21 INFO - Using real prefix '/usr' 02:56:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:56:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:56:23 INFO - Installing pip.................done. 02:56:23 INFO - Return code: 0 02:56:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:56:23 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')]} 02:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:23 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')]} 02:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:23 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 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:23 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 02:56:23 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 02:56:23 INFO - Using env: {'DISPLAY': ':0', 02:56:23 INFO - 'HOME': '/home/cltbld', 02:56:23 INFO - 'LANG': 'en_US.UTF-8', 02:56:23 INFO - 'LANGUAGE': 'en_US:en', 02:56:23 INFO - 'LOGNAME': 'cltbld', 02:56:23 INFO - 'MAIL': '/var/mail/cltbld', 02:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:23 INFO - 'MOZ_NO_REMOTE': '1', 02:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:23 INFO - 'NO_EM_RESTART': '1', 02:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:23 INFO - 'PWD': '/builds/slave/test', 02:56:23 INFO - 'SHELL': '/bin/bash', 02:56:23 INFO - 'SHLVL': '1', 02:56:23 INFO - 'TERM': 'linux', 02:56:23 INFO - 'TMOUT': '86400', 02:56:23 INFO - 'USER': 'cltbld', 02:56:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:23 INFO - '_': '/tools/buildbot/bin/python'} 02:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:23 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 02:56:23 INFO - Cleaning up... 02:56:23 INFO - Return code: 0 02:56:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56:23 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')]} 02:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:23 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')]} 02:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:23 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 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:23 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 02:56:23 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 02:56:23 INFO - Using env: {'DISPLAY': ':0', 02:56:23 INFO - 'HOME': '/home/cltbld', 02:56:23 INFO - 'LANG': 'en_US.UTF-8', 02:56:23 INFO - 'LANGUAGE': 'en_US:en', 02:56:23 INFO - 'LOGNAME': 'cltbld', 02:56:23 INFO - 'MAIL': '/var/mail/cltbld', 02:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:23 INFO - 'MOZ_NO_REMOTE': '1', 02:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:23 INFO - 'NO_EM_RESTART': '1', 02:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:23 INFO - 'PWD': '/builds/slave/test', 02:56:23 INFO - 'SHELL': '/bin/bash', 02:56:23 INFO - 'SHLVL': '1', 02:56:23 INFO - 'TERM': 'linux', 02:56:23 INFO - 'TMOUT': '86400', 02:56:23 INFO - 'USER': 'cltbld', 02:56:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:23 INFO - '_': '/tools/buildbot/bin/python'} 02:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:23 INFO - Downloading/unpacking psutil>=3.1.1 02:56:23 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 02:56:23 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 02:56:23 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 02:56:23 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 02:56:23 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 02:56:23 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 02:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:25 INFO - Installing collected packages: psutil 02:56:25 INFO - Running setup.py install for psutil 02:56:25 INFO - building 'psutil._psutil_linux' extension 02:56:25 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 02:56:26 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 02:56:26 INFO - building 'psutil._psutil_posix' extension 02:56:26 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 02:56:26 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 02:56:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:26 INFO - Successfully installed psutil 02:56:26 INFO - Cleaning up... 02:56:26 INFO - Return code: 0 02:56:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:56:26 INFO - Using env: {'DISPLAY': ':0', 02:56:26 INFO - 'HOME': '/home/cltbld', 02:56:26 INFO - 'LANG': 'en_US.UTF-8', 02:56:26 INFO - 'LANGUAGE': 'en_US:en', 02:56:26 INFO - 'LOGNAME': 'cltbld', 02:56:26 INFO - 'MAIL': '/var/mail/cltbld', 02:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:26 INFO - 'MOZ_NO_REMOTE': '1', 02:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:26 INFO - 'NO_EM_RESTART': '1', 02:56:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:26 INFO - 'PWD': '/builds/slave/test', 02:56:26 INFO - 'SHELL': '/bin/bash', 02:56:26 INFO - 'SHLVL': '1', 02:56:26 INFO - 'TERM': 'linux', 02:56:26 INFO - 'TMOUT': '86400', 02:56:26 INFO - 'USER': 'cltbld', 02:56:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:26 INFO - '_': '/tools/buildbot/bin/python'} 02:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56:26 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 02:56:26 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 02:56:26 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 02:56:26 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 02:56:26 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 02:56:26 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 02:56:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:28 INFO - Installing collected packages: mozsystemmonitor 02:56:28 INFO - Running setup.py install for mozsystemmonitor 02:56:28 INFO - Successfully installed mozsystemmonitor 02:56:28 INFO - Cleaning up... 02:56:28 INFO - Return code: 0 02:56:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56:28 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')]} 02:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:28 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')]} 02:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:28 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 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:28 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 02:56:28 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 02:56:28 INFO - Using env: {'DISPLAY': ':0', 02:56:28 INFO - 'HOME': '/home/cltbld', 02:56:28 INFO - 'LANG': 'en_US.UTF-8', 02:56:28 INFO - 'LANGUAGE': 'en_US:en', 02:56:28 INFO - 'LOGNAME': 'cltbld', 02:56:28 INFO - 'MAIL': '/var/mail/cltbld', 02:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:28 INFO - 'MOZ_NO_REMOTE': '1', 02:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:28 INFO - 'NO_EM_RESTART': '1', 02:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:28 INFO - 'PWD': '/builds/slave/test', 02:56:28 INFO - 'SHELL': '/bin/bash', 02:56:28 INFO - 'SHLVL': '1', 02:56:28 INFO - 'TERM': 'linux', 02:56:28 INFO - 'TMOUT': '86400', 02:56:28 INFO - 'USER': 'cltbld', 02:56:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:28 INFO - '_': '/tools/buildbot/bin/python'} 02:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:28 INFO - Downloading/unpacking jsonschema==2.5.1 02:56:28 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 02:56:28 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 02:56:28 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 02:56:28 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 02:56:28 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 02:56:28 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 02:56:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:31 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:31 INFO - warning: no files found matching '*.txt' 02:56:31 INFO - no previously-included directories found matching 'build' 02:56:31 INFO - no previously-included directories found matching 'dist' 02:56:31 INFO - no previously-included directories found matching '.git*' 02:56:31 INFO - Installing collected packages: jsonschema, functools32 02:56:31 INFO - Running setup.py install for functools32 02:56:31 INFO - warning: no files found matching '*.txt' 02:56:31 INFO - no previously-included directories found matching 'build' 02:56:31 INFO - no previously-included directories found matching 'dist' 02:56:31 INFO - no previously-included directories found matching '.git*' 02:56:31 INFO - Successfully installed jsonschema functools32 02:56:31 INFO - Cleaning up... 02:56:31 INFO - Return code: 0 02:56:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:31 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 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:31 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 02:56:31 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 02:56:31 INFO - Using env: {'DISPLAY': ':0', 02:56:31 INFO - 'HOME': '/home/cltbld', 02:56:31 INFO - 'LANG': 'en_US.UTF-8', 02:56:31 INFO - 'LANGUAGE': 'en_US:en', 02:56:31 INFO - 'LOGNAME': 'cltbld', 02:56:31 INFO - 'MAIL': '/var/mail/cltbld', 02:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:31 INFO - 'MOZ_NO_REMOTE': '1', 02:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:31 INFO - 'NO_EM_RESTART': '1', 02:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:31 INFO - 'PWD': '/builds/slave/test', 02:56:31 INFO - 'SHELL': '/bin/bash', 02:56:31 INFO - 'SHLVL': '1', 02:56:31 INFO - 'TERM': 'linux', 02:56:31 INFO - 'TMOUT': '86400', 02:56:31 INFO - 'USER': 'cltbld', 02:56:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:31 INFO - '_': '/tools/buildbot/bin/python'} 02:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:56:31 INFO - Cleaning up... 02:56:31 INFO - Return code: 0 02:56:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:31 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 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:31 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 02:56:31 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 02:56:31 INFO - Using env: {'DISPLAY': ':0', 02:56:31 INFO - 'HOME': '/home/cltbld', 02:56:31 INFO - 'LANG': 'en_US.UTF-8', 02:56:31 INFO - 'LANGUAGE': 'en_US:en', 02:56:31 INFO - 'LOGNAME': 'cltbld', 02:56:31 INFO - 'MAIL': '/var/mail/cltbld', 02:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:31 INFO - 'MOZ_NO_REMOTE': '1', 02:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:31 INFO - 'NO_EM_RESTART': '1', 02:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:31 INFO - 'PWD': '/builds/slave/test', 02:56:31 INFO - 'SHELL': '/bin/bash', 02:56:31 INFO - 'SHLVL': '1', 02:56:31 INFO - 'TERM': 'linux', 02:56:31 INFO - 'TMOUT': '86400', 02:56:31 INFO - 'USER': 'cltbld', 02:56:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:31 INFO - '_': '/tools/buildbot/bin/python'} 02:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:56:31 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 02:56:31 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 02:56:31 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 02:56:31 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 02:56:31 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 02:56:31 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 02:56:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:56:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:56:33 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 02:56:33 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 02:56:33 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 02:56:33 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 02:56:33 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 02:56:33 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 02:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:56:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:34 INFO - Downloading docopt-0.6.1.tar.gz 02:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:56:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:56:34 INFO - Running setup.py install for blobuploader 02:56:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:56:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:56:34 INFO - Running setup.py install for requests 02:56:34 INFO - Running setup.py install for docopt 02:56:34 INFO - Successfully installed blobuploader requests docopt 02:56:34 INFO - Cleaning up... 02:56:35 INFO - Return code: 0 02:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:35 INFO - Using env: {'DISPLAY': ':0', 02:56:35 INFO - 'HOME': '/home/cltbld', 02:56:35 INFO - 'LANG': 'en_US.UTF-8', 02:56:35 INFO - 'LANGUAGE': 'en_US:en', 02:56:35 INFO - 'LOGNAME': 'cltbld', 02:56:35 INFO - 'MAIL': '/var/mail/cltbld', 02:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:35 INFO - 'MOZ_NO_REMOTE': '1', 02:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:35 INFO - 'NO_EM_RESTART': '1', 02:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:35 INFO - 'PWD': '/builds/slave/test', 02:56:35 INFO - 'SHELL': '/bin/bash', 02:56:35 INFO - 'SHLVL': '1', 02:56:35 INFO - 'TERM': 'linux', 02:56:35 INFO - 'TMOUT': '86400', 02:56:35 INFO - 'USER': 'cltbld', 02:56:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:35 INFO - '_': '/tools/buildbot/bin/python'} 02:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:35 INFO - Running setup.py (path:/tmp/pip-6wcW4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:35 INFO - Running setup.py (path:/tmp/pip-SUlTLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:35 INFO - Running setup.py (path:/tmp/pip-587pun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:35 INFO - Running setup.py (path:/tmp/pip-XOzLbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:35 INFO - Running setup.py (path:/tmp/pip-yuYYkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:35 INFO - Running setup.py (path:/tmp/pip-rElyYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:35 INFO - Running setup.py (path:/tmp/pip-_vxRaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:35 INFO - Running setup.py (path:/tmp/pip-BjaEWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:35 INFO - Running setup.py (path:/tmp/pip-0RR5H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:35 INFO - Running setup.py (path:/tmp/pip-jbQsmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:35 INFO - Running setup.py (path:/tmp/pip-_C1AwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:36 INFO - Running setup.py (path:/tmp/pip-_zFb7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:36 INFO - Running setup.py (path:/tmp/pip-AArLuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:36 INFO - Running setup.py (path:/tmp/pip-usaduC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:36 INFO - Running setup.py (path:/tmp/pip-ZanWap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:36 INFO - Running setup.py (path:/tmp/pip-jdXL74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:36 INFO - Running setup.py (path:/tmp/pip-IZhSFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:36 INFO - Running setup.py install for manifestparser 02:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:36 INFO - Running setup.py install for mozcrash 02:56:36 INFO - Running setup.py install for mozdebug 02:56:36 INFO - Running setup.py install for mozdevice 02:56:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:56:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:36 INFO - Running setup.py install for mozfile 02:56:36 INFO - Running setup.py install for mozhttpd 02:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozinfo 02:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozInstall 02:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozleak 02:56:37 INFO - Running setup.py install for mozlog 02:56:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for moznetwork 02:56:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozprocess 02:56:37 INFO - Running setup.py install for mozprofile 02:56:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozrunner 02:56:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:37 INFO - Running setup.py install for mozscreenshot 02:56:38 INFO - Running setup.py install for moztest 02:56:38 INFO - Running setup.py install for mozversion 02:56:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:38 INFO - Cleaning up... 02:56:38 INFO - Return code: 0 02:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:38 INFO - Using env: {'DISPLAY': ':0', 02:56:38 INFO - 'HOME': '/home/cltbld', 02:56:38 INFO - 'LANG': 'en_US.UTF-8', 02:56:38 INFO - 'LANGUAGE': 'en_US:en', 02:56:38 INFO - 'LOGNAME': 'cltbld', 02:56:38 INFO - 'MAIL': '/var/mail/cltbld', 02:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:38 INFO - 'MOZ_NO_REMOTE': '1', 02:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:38 INFO - 'NO_EM_RESTART': '1', 02:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:38 INFO - 'PWD': '/builds/slave/test', 02:56:38 INFO - 'SHELL': '/bin/bash', 02:56:38 INFO - 'SHLVL': '1', 02:56:38 INFO - 'TERM': 'linux', 02:56:38 INFO - 'TMOUT': '86400', 02:56:38 INFO - 'USER': 'cltbld', 02:56:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:38 INFO - '_': '/tools/buildbot/bin/python'} 02:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:38 INFO - Running setup.py (path:/tmp/pip-nzxgAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:38 INFO - Running setup.py (path:/tmp/pip-Xc9HgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:38 INFO - Running setup.py (path:/tmp/pip-37w8__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:38 INFO - Running setup.py (path:/tmp/pip-V07YF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:38 INFO - Running setup.py (path:/tmp/pip-vUQtAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:38 INFO - Running setup.py (path:/tmp/pip-h5OokB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:38 INFO - Running setup.py (path:/tmp/pip-42SCD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:38 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)) 02:56:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:38 INFO - Running setup.py (path:/tmp/pip-jtVfZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:39 INFO - Running setup.py (path:/tmp/pip-xfY0V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:39 INFO - Running setup.py (path:/tmp/pip-13FzK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:39 INFO - Running setup.py (path:/tmp/pip-Fd2O2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:39 INFO - Running setup.py (path:/tmp/pip-F9GzIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:39 INFO - Running setup.py (path:/tmp/pip-G88dr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:39 INFO - Running setup.py (path:/tmp/pip-Pqcwgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:39 INFO - Running setup.py (path:/tmp/pip-PfzPJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:39 INFO - Running setup.py (path:/tmp/pip-XPLh39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:39 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)) 02:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:39 INFO - Running setup.py (path:/tmp/pip-pLMYs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:39 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)) 02:56:39 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)) 02:56:39 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)) 02:56:39 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)) 02:56:39 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)) 02:56:39 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)) 02:56:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:39 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 02:56:41 INFO - Downloading blessings-1.6.tar.gz 02:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:41 INFO - Installing collected packages: blessings 02:56:41 INFO - Running setup.py install for blessings 02:56:41 INFO - Successfully installed blessings 02:56:41 INFO - Cleaning up... 02:56:41 INFO - Return code: 0 02:56:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:42 INFO - Reading from file tmpfile_stdout 02:56:42 INFO - Current package versions: 02:56:42 INFO - argparse == 1.2.1 02:56:42 INFO - blessings == 1.6 02:56:42 INFO - blobuploader == 1.2.4 02:56:42 INFO - docopt == 0.6.1 02:56:42 INFO - functools32 == 3.2.3-2 02:56:42 INFO - jsonschema == 2.5.1 02:56:42 INFO - manifestparser == 1.1 02:56:42 INFO - mozInstall == 1.12 02:56:42 INFO - mozcrash == 0.17 02:56:42 INFO - mozdebug == 0.1 02:56:42 INFO - mozdevice == 0.48 02:56:42 INFO - mozfile == 1.2 02:56:42 INFO - mozhttpd == 0.7 02:56:42 INFO - mozinfo == 0.9 02:56:42 INFO - mozleak == 0.1 02:56:42 INFO - mozlog == 3.3 02:56:42 INFO - moznetwork == 0.27 02:56:42 INFO - mozprocess == 0.23 02:56:42 INFO - mozprofile == 0.28 02:56:42 INFO - mozrunner == 6.12 02:56:42 INFO - mozscreenshot == 0.1 02:56:42 INFO - mozsystemmonitor == 0.3 02:56:42 INFO - moztest == 0.7 02:56:42 INFO - mozversion == 1.4 02:56:42 INFO - psutil == 3.1.1 02:56:42 INFO - requests == 1.2.3 02:56:42 INFO - wsgiref == 0.1.2 02:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:56:42 INFO - Using env: {'DISPLAY': ':0', 02:56:42 INFO - 'HOME': '/home/cltbld', 02:56:42 INFO - 'LANG': 'en_US.UTF-8', 02:56:42 INFO - 'LANGUAGE': 'en_US:en', 02:56:42 INFO - 'LOGNAME': 'cltbld', 02:56:42 INFO - 'MAIL': '/var/mail/cltbld', 02:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:42 INFO - 'MOZ_NO_REMOTE': '1', 02:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:42 INFO - 'NO_EM_RESTART': '1', 02:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:42 INFO - 'PWD': '/builds/slave/test', 02:56:42 INFO - 'SHELL': '/bin/bash', 02:56:42 INFO - 'SHLVL': '1', 02:56:42 INFO - 'TERM': 'linux', 02:56:42 INFO - 'TMOUT': '86400', 02:56:42 INFO - 'USER': 'cltbld', 02:56:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:42 INFO - '_': '/tools/buildbot/bin/python'} 02:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:56:42 INFO - Cleaning up... 02:56:42 INFO - Return code: 0 02:56:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ed1400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', '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 02:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:56:42 INFO - Using env: {'DISPLAY': ':0', 02:56:42 INFO - 'HOME': '/home/cltbld', 02:56:42 INFO - 'LANG': 'en_US.UTF-8', 02:56:42 INFO - 'LANGUAGE': 'en_US:en', 02:56:42 INFO - 'LOGNAME': 'cltbld', 02:56:42 INFO - 'MAIL': '/var/mail/cltbld', 02:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:42 INFO - 'MOZ_NO_REMOTE': '1', 02:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:42 INFO - 'NO_EM_RESTART': '1', 02:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:42 INFO - 'PWD': '/builds/slave/test', 02:56:42 INFO - 'SHELL': '/bin/bash', 02:56:42 INFO - 'SHLVL': '1', 02:56:42 INFO - 'TERM': 'linux', 02:56:42 INFO - 'TMOUT': '86400', 02:56:42 INFO - 'USER': 'cltbld', 02:56:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:42 INFO - '_': '/tools/buildbot/bin/python'} 02:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:42 INFO - Cleaning up... 02:56:42 INFO - Return code: 0 02:56:42 INFO - Running post-action listener: _resource_record_post_action 02:56:42 INFO - Running post-action listener: _start_resource_monitoring 02:56:42 INFO - Starting resource monitoring. 02:56:42 INFO - [mozharness: 2016-08-17 09:56:42.547335Z] Finished create-virtualenv step (success) 02:56:42 INFO - [mozharness: 2016-08-17 09:56:42.547929Z] Running install step. 02:56:42 INFO - Running pre-action listener: _resource_record_pre_action 02:56:42 INFO - Running main action method: install 02:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:42 INFO - Reading from file tmpfile_stdout 02:56:42 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:42 INFO - Reading from file tmpfile_stdout 02:56:42 INFO - Output received: 02:56:42 INFO - Usage: mozinstall [options] installer 02:56:42 INFO - Options: 02:56:42 INFO - -h, --help show this help message and exit 02:56:42 INFO - -d DEST, --destination=DEST 02:56:42 INFO - Directory to install application into. [default: 02:56:42 INFO - "/builds/slave/test"] 02:56:42 INFO - --app=APP Application being installed. [default: firefox] 02:56:42 INFO - mkdir: /builds/slave/test/build/application 02:56:42 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'] 02:56:42 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 02:56:59 INFO - Reading from file tmpfile_stdout 02:56:59 INFO - Output received: 02:56:59 INFO - /builds/slave/test/build/application/firefox/firefox 02:56:59 INFO - Running post-action listener: _resource_record_post_action 02:56:59 INFO - [mozharness: 2016-08-17 09:56:59.598224Z] Finished install step (success) 02:56:59 INFO - [mozharness: 2016-08-17 09:56:59.598502Z] Running run-tests step. 02:56:59 INFO - Running pre-action listener: _resource_record_pre_action 02:56:59 INFO - Running main action method: run_tests 02:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:59 INFO - Python 2.7.3 02:56:59 INFO - Return code: 0 02:56:59 INFO - grabbing minidump binary from tooltool 02:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:59 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 0x1f60570>, '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 0x1f61470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f61900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:59 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 02:56:59 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 02:56:59 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 02:56:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:59 INFO - Return code: 0 02:56:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:56:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:59 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/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:56:59 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/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 02:56:59 INFO - Using env: {'DISPLAY': ':0', 02:56:59 INFO - 'HOME': '/home/cltbld', 02:56:59 INFO - 'LANG': 'en_US.UTF-8', 02:56:59 INFO - 'LANGUAGE': 'en_US:en', 02:56:59 INFO - 'LOGNAME': 'cltbld', 02:56:59 INFO - 'MAIL': '/var/mail/cltbld', 02:56:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:59 INFO - 'MOZ_NO_REMOTE': '1', 02:56:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:59 INFO - 'NO_EM_RESTART': '1', 02:56:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:59 INFO - 'PWD': '/builds/slave/test', 02:56:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:59 INFO - 'SHELL': '/bin/bash', 02:56:59 INFO - 'SHLVL': '1', 02:56:59 INFO - 'TERM': 'linux', 02:56:59 INFO - 'TMOUT': '86400', 02:56:59 INFO - 'USER': 'cltbld', 02:56:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913', 02:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:59 INFO - '_': '/tools/buildbot/bin/python'} 02:56:59 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/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 02:56:59 INFO - mozversion application_buildid: 20160817000116 02:56:59 INFO - mozversion application_changeset: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 02:56:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:56:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:59 INFO - mozversion application_name: Firefox 02:56:59 INFO - mozversion application_remotingname: firefox-dev 02:56:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:59 INFO - mozversion application_vendor: Mozilla 02:56:59 INFO - mozversion application_version: 50.0a2 02:56:59 INFO - mozversion platform_buildid: 20160817000116 02:56:59 INFO - mozversion platform_changeset: fdc2f1d67e3977e4fbc79d0acbb32259eca0f524 02:56:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:59 INFO - mozversion platform_version: 50.0a2 02:56:59 INFO - using testdate: 1471427819 02:56:59 INFO - actual date: 1471427819 02:56:59 INFO - starting webserver on 'localhost:45646' 02:56:59 INFO - SUITE-START | Running 2 tests 02:56:59 INFO - TEST-START | dromaeo_css 02:56:59 INFO - operating with platform_type : linux_ 02:56:59 INFO - Initialising browser for dromaeo_css test... 02:56:59 INFO - TEST-INFO | started process 700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZJqKaJ/profile http://localhost:45646/getInfo.html) 02:57:04 INFO - PROCESS | 700 | __metrics Screen width/height:1600/1200 02:57:04 INFO - PROCESS | 700 | colorDepth:24 02:57:04 INFO - PROCESS | 700 | Browser inner width/height: 1024/697 02:57:04 INFO - PROCESS | 700 | __metrics 02:57:05 ERROR - PROCESS | 700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:57:06 INFO - TEST-INFO | 700: exit 0 02:57:06 INFO - Browser initialized. 02:57:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:06 INFO - TEST-INFO | started process 836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZJqKaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:17 INFO - PROCESS | 836 | RSS: Main: 152768512 02:57:17 INFO - PROCESS | 836 | 02:58:07 INFO - PROCESS | 836 | 1471427887420 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:00:15 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45646/tests/dromaeo/cssquery-ext.html) 03:00:17 INFO - PROCESS | 836 | RSS: Main: 158056448 03:00:17 INFO - PROCESS | 836 | 03:03:19 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-ext.html (next: http://localhost:45646/tests/dromaeo/cssquery-jquery.html) 03:03:19 INFO - PROCESS | 836 | RSS: Main: 153174016 03:03:19 INFO - PROCESS | 836 | 03:06:21 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45646/tests/dromaeo/cssquery-mootools.html) 03:06:22 INFO - PROCESS | 836 | RSS: Main: 153862144 03:06:22 INFO - PROCESS | 836 | 03:09:23 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45646/tests/dromaeo/cssquery-prototype.html) 03:09:24 INFO - PROCESS | 836 | RSS: Main: 153083904 03:09:24 INFO - PROCESS | 836 | 03:12:26 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45646/tests/dromaeo/cssquery-yui.html) 03:12:27 INFO - PROCESS | 836 | RSS: Main: 154841088 03:12:27 INFO - PROCESS | 836 | 03:15:29 INFO - PROCESS | 836 | Cycle 1(1): loaded http://localhost:45646/tests/dromaeo/cssquery-yui.html (next: http://localhost:45646/tests/dromaeo/cssquery-dojo.html) 03:15:30 INFO - PROCESS | 836 | RSS: Main: 156090368 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | __start_tp_report 03:15:30 INFO - PROCESS | 836 | _x_x_mozilla_page_load 03:15:30 INFO - PROCESS | 836 | _x_x_mozilla_page_load_details 03:15:30 INFO - PROCESS | 836 | |i|pagename|runs| 03:15:30 INFO - PROCESS | 836 | |0;dojo.html;3307.9007629771104;3343.2979074394375;3348.2968576598914;3366.057503898909;3376.307856889338;5830.038043722786;5839.6496210227415;5927.318358388787;5932.466078052975;5938.673372964486;5723.198752174689;5782.710864456782;5841.299044114701;5841.824745257639;5846.23998880145;5179.870503237412;5321.175217841241;5335.279737235482;5365.141577347626;5369.463053694639;5240.030594340059;5251.264822924793;5281.841544753664;5333.386660534049;5381.919271210935;5299.947000529984;5325.7603407846545;5328.387235467912;5328.413874473805;5334.386545547253;5355.9196612050655;5368.194770784394;5372.409035006146;5387;5393.622446428752;5115.104856650109;5184.248283998799;5222.112240919053;5265.921011184835;5266.210068489719;5767.942320576783;5825.592208545403;5825.679587622679;5864.648121112747;5887.705614719247;6229.750809967596;6265.310815810257;6267.4672652824565;6271.655058971754;6311.211098612674;6057.878842423171;6130.459285710746;6160.537959652999;6334.113224148623;6336.873262534724;5876.500497457721;5879.353271140171;5888.028475301528;5891.617044892068;5917.171595976567;6415.67921603918;6452.161219041494;6466.224053113562;6485.092087107809;6486.643234622141;5943.375945525658;6097.2683278006925;6115.4801841843055;6123.908141377883;6191.907121393093;6252.374762523711;6277.403646653561;6296.527760417987;6303.527235457359;6319.304876463585;6280.2777680566405;6287.49700023997;6287.685615719196;6292.748290068437;6309.179806625201;6040.637561746309;6122.550631082941;6125.632462052291;6257;6260.686965651699;4747.430308362949;4752.239641657318;4775.73733444657;4790.4251489821445;4801.207800712913;4224.704270701083;4232.788360581959;4240.978795106004;4241.045764702917;4269.530351661315;5889.793857214977;5924.851878702981;5943.673097979567;5947.583669143205;5978.04351303798;6272.498200143978;6321.810345689637;6323.557350985387;6327.588706734047;6331.176946996861;6063.272407311063;6064.514838812973;6075.2405949256345;6075.665838378844;6077.179580756541;5265.420803711589;5343.7060961647485;5387.46125387466;5434.864128396822;5480.177973304037;6563;6565.409113179837;6573.079768832367;6587.736490540325;6624.635645039472;6234.719437625408;6310.2743184534365;6326;6335.809925702236;6357.93642063592;6246.031865060922;6400.45596124316;6445.419912207736;6504.804855854332;6572.737090516326;6146.200993870947;6159.753609855735;6170.382961703794;6189;6198.597091189058;6267.843303917439;6272.937270627235;6281.309056003744;6302.968485157545;6314.494840412848;5920.200772895776;6039;6080.087986801838;6157.291911430243;6182.041783523561;6079.392060794062;6105.17580126695;6112.38876112403;6122.764110201883;6134.355892631388;6041.879162416815;6047.334793172836;6076.149339092619;6079.270487541523;6103.664298463627;5980.551458640706;6096.8780624388155;6135.601185922901;6167.352427994996;6176.876462470816;6045;6048.697565121638;6053.667048312209;6061.333253342217;6062.5453091019235 03:15:30 INFO - PROCESS | 836 | |1;ext.html;582.1675004743215;637.4135795068537;661.7253839656541;661.864317814848;697.5570512724419;42369.78815105924;47609.285860712116;47656.285155722646;47690.76154619222;47824.52175478244;47938.280925786145;48704;48795.75602121993;48844.51155488444;48890.51109488904;9073.773155671111;9199;9234.722958311262;9257.213136883372;9263.6294548218;9089.909100909006;9204.631814727403;9239.722808315728;9247.21398681113;9268.860967085466;9295;9305.11601397866;9321.953390233073;9341.346105772598;9364.531773411301;9105.317101217435;9165.770855728626;9247.167754902091;9267.25861931044;9275.397099188565;9122.817543649157;9168.541572921395;9174.174324310845;9180.678676246365;9188.127127922837;44874.32688509675;44977.10045799066;45196.09607807858;45573.77213113946;45671;4156.397322388237;4209.7474151551005;4444.599986001275;4560.521145279764;4697.201475749097;35586.466203006974;36435.453468198;36563.81718091419;36572.451413228824;36903.81548092242;4101.753894766293;4103.158852435274;4157.667386609064;4166;4277.123189746095;403286;406572.99999999703;407496;408671;409664;39435;70677.2932270681;70846.29153708398;71315.64342178256;71493.64253178805;39582.406263906065;41055.589444105775;41512.377314339705;41545;41717.79141104275;16126.516204513884;16292.755608665879;16301.184940752915;16301.91849040771;16302.83697163037;12188.81716774249;12197.024238060934;12256.203346782431;12267.386630668609;12287.262764234174;9258.444493330422;9289.814203715889;9308.581113849894;9329.44023358587;9349.252059835197;3514.3674138655288;3516.4373700207843;3549.272399158218;3576.1059735066233;3576.40989236773;1083.3445765311874;1094.2887123369715;1125.7298248420484;1152.1071169843437;1170.9063274937985;36203;36333.0916727084;36368;36422;36733.63266367302;1197.245735186844;1255.604484587352;1267.0623738433676;1268.1820225954393;1332.2073366347008;18396.908015459838;18520.16659250337;18687.252509899452;18690.906545467187;18754.1560629772;593501;595379;596219;598260;601608;66872.33127668759;67093.664531678;67315.66342168258;67373.32626673768;67723;1426.5934208750457;1470.8161479815024;1472.8527147285185;1479.6522817137964;1499.1005396761855;35947.87801109749;36101.23071243583;36169.55352770053;36463.45304820483;36571.45142822913;57865.13202301884;58929;59184.40815591789;59368;59420.10869837042;528574;534422;536093;536694;537562;31993.840030799696;31997;32158.839205803823;32437.35125297528;32470.675293246764;55269.44730552804;55543;55574.72212639073;58276.54308642318;58728.41271587229;46600.30099548577;48670.5132948666;48710.512894872016;48953.265701015225;49240.26139607837;48389.27416088832;48592.75703621459;48696.5130348692;48808.51191488039;49205;46975;48044;48062.27906581334;48196.7590162047;48367.5163248363;38508.42237366498;40683.18633627252;40923.38614920838;41123.181183974724;41804.58195418007;31518.369632606762;31617.683823161475;31884.202894927814;31894.36211275715;32438 03:15:30 INFO - PROCESS | 836 | |2;jquery.html;403.69117625016884;409.2183928696187;414.52122798168114;417.2135524536248;431.45851955795473;18776.812231877695;20036.69944950827;20181.88999605023;20470.89764551177;20894.89552552239;19618.313359032436;19791.802081979175;20380.184792608314;20505.17979280827;20633.587328253427;5164.096283150452;5392.299001129848;5404.513593776559;5462.781488740446;5477.67133971961;5398.352197736258;5425.050616142179;5823.213866128082;5865.706714664249;5884.794032208873;6017.939820601781;6019.277686677605;6029.909551356711;6030.33666296707;6044.395560443964;6025.246844144482;6037.969810150943;6059.454649081582;6076.696165191723;6077.544184186204;5343.118385466393;5420.783168673248;5460.071787796044;5472.5621950243885;5481.780728770845;14903.403863845433;15242.466513671969;15305.387784488606;15370.308336124901;22371.32886013422;2325.4883925536355;2426.5146970605774;2482.8013758899247;2627.1987043951585;3111.7821752477334;10148.797024059477;10223.846642300372;10255.282130250886;10338.896611033944;10568;1937.7384053152784;2046.9897650511653;2049.549099198174;2056.0028386232666;2104.7474303083577;78294;83591;86156;87812;88425.99999999936;11340.886591133984;11424.828627570592;11603.720307260344;11611.65165045033;11802.88197118035;16235.756463653055;16266.18669066542;16273.755893661604;16370.918145409196;16605.750913736305;8485.95757021211;8501.829963400698;8818.206361427503;8851.203391694778;8884.511351875579;8472.068072512142;8603.956980215184;8622.611982460805;8667.869981950276;8777.956110219537;4924.655274130848;5043.268726034705;5048.823291184791;5051.671641343374;5125.974370128126;1965.7051442283487;2023.261509549004;2030.6953956906582;2039.6022775558624;2045.877247365163;478.6601512925862;479.70498143642106;901.9278457723498;964.9048330145196;1014.4420568687193;12691.428885700165;13162.60512184636;13298.202107873558;13337.599872003855;13467.730645387233;501.9648624596316;509.47015104291864;514.2081194959795;528.5586535243038;537.1841441477176;6038.275406951194;6757.155355580552;6821.488388370892;6952.304769523007;7038.577685338793;483101;517046;534114;539273;539746;89752.5512372434;94520;101861;103608.48195758973;106839.46580267049;1079.4818487126224;1113.1095123900848;1124.201816710145;1134.9375784331776;1141.3779490177874;18768.812311876707;18927.337543185924;19224.519387015436;19371.515712106746;19391.2243510258;34745.8262708695;44464;44534.77732611316;45358.54641453675;45712.771436142604;58907;59375.70312148412;62767.6861615689;68597.65701171462;68800;8555.957220213859;9013.143751343612;9052.90947090547;9146.57902360543;9368.906310937076;13596.388162532907;14161.858381416054;14424.206668633326;14546.636334091309;14590.489332873298;11972;12098.818517722066;12231.327276999851;12592.496300148257;12788.424520896397;8755.387122901337;12242.510299587917;12336.691582710504;12669;12716.618501444971;12421.441035153259;12426.440810163745;12882.549110781078;12943.482260709843;13201.141925774795;8606.698765543177;8655.6970506032;8701.521416322163;8785.25325347327;8797.85627868373;8833.779155520906;11797.88202117968;12087.39563021863;12361;12565.497380104693 03:15:30 INFO - PROCESS | 836 | |3;mootools.html;1565.483390481141;1594.96012599685;1745.9563510912226;1822.0525326830057;1823.498537902076;8726.738197854074;9395.389299695524;9478.715638530837;10155.238357123217;10167.542460589273;9456.91245506767;9872.16086632637;9887.555060022298;9905.455199963999;9913.553890074963;2551.272887227136;2592.857392843393;2596.363890846745;2597.3246955791537;2602.3754298968206;2517.874106294687;2595.9221223363234;2596.9610455843176;2597.6623039005;2598.649182360376;2541.186820217531;2546.567083595793;2577.90977315794;2598.753118453744;2604.387968827324;2452.828302018859;2458.9754102459015;2465.8767061647027;2472.208893154191;2495.5258500884956;2470.1354525915967;2477.2444404456633;2485.801135909123;2504.586743187372;2535.4802265535523;9930.404175749478;10085.243606729451;10093.142082922886;10094.444805535693;10121.848172277421;5692.601517893708;5814.360420353758;5815.244018277597;5826.271716035496;5826.329972053183;3373.1229880231317;3406.267652454709;3477;3485.3203625292826;3592.281543691246;1043.8184195032418;1062.5696592879897;1072.3190773858578;1082.983755243672;1098.1489345757102;13942.442302307896;14008.789868151986;14100.365483553265;14121.15273083608;14128.293585320796;4863.927041094386;4958.9008219835405;5096.362954630671;5167.457416971239;5180.844574662766;11801.763964720829;11900.880991189977;11913.70215744596;11924.88075119255;11939.88060119405;5869.882602347929;5895.056790913433;5903.498202652822;5908.822735317947;5914.349421563625;4661.603763680057;5104.05574968632;5219.451957544479;5233.502817232356;5422.240886275925;4258.787060646955;4320.287152619845;4402.625776808943;4469.039156581351;4472.239719247736;1307.7972914198124;1322.2463195978391;1334.4328660319325;1339.2031741114022;1358.3140514040545;929.1823195587839;978.2516374973151;1040.625374865048;1056.2975621211963;1132.869719982196;6567.474602031826;6700.199297712826;6974.860502789916;6986.196587392414;7029.086218791626;1001.7996400719885;1010.4644538394663;1028.5834237133972;1046.1682962045193;1054.177741361739;4748.810047598126;4922.1140194765285;4922.803087876517;4937.925931111036;4953.8018479261145;11560.306381616962;11925.582604608971;12214.755704885853;12529.43617537213;12581.37093145339;12297.815532767016;12311.630651080482;12339.50641974329;12367;12402.379881006094;8847.159519845605;9114.908850911539;9146.131117543822;9155.45067295951;9163.175314221751;6911.7926462206215;7059.399951004222;7136.143662760502;7172.175199852084;7247.275272472922;11255.887441125484;11272.830907536558;11429.828552571551;11568.132390070947;11654.359010254517;11321.830172547254;11618.535258589562;11636.825447618123;11884.049276058067;11888.167828252286;7747.573883436465;8275.875861862198;8419.663213471393;8692.52191129494;8814.86777698348;9776.951115244377;9787.46168960714;9807.803843923224;9865.802683946424;9868.210543156674;8232.711855085283;8421.115782842959;8650.740477785677;8656.78358041054;8748.2126608603;8583.871241931502;8709.390342675952;8713.085126061926;8735.91264087351;8827.514486703292;8121.878171827546;8157.918420815716;8172.42793004484;8175.959120204361;8192.057913340042;5876.08920617305;5912.5861189718025;6032.969835150971;6043.728032238648;6073.423024812636;6017.849553761191;6077.726502307319;6088.6042407243385;6201.627902325875;6217.502599792097 03:15:30 INFO - PROCESS | 836 | |4;prototype.html;337.27822459935743;347.9301148966927;350.73694728953285;351.17123588331543;351.5640605648994;5657.264555607765;5718.971405142979;5854.560907931901;5870.647761134335;5888.263967004124;5713.857153571163;5731.856703582413;5772.163036359725;5773.913391299134;5779.971100144504;4538.7503687297185;4561.726296422209;4564.338170965217;4568.771561421932;4579.702319349249;4481;4518.661100417482;4519.5932366087045;4527.20773864574;4544.477385100706;4442.756408013965;4447.510773814878;4460.776961151945;4461.531539188387;4492.820287188509;4475.597196252336;4503.864884053483;4511.323301504801;4515.796789144496;4536.8638940831825;3871.9032024199337;3979.5423526294267;3986.222686576119;4020.7885662885296;4029.435878976946;5595.677793715603;5636.351819540764;5637.7181140942785;5688.459596338341;5697.1739097831;5200.479952004807;5239.816606418795;5254.474552544753;5255.789768409298;5259.3951695555115;5944;6039.5772295939305;6074.817755467343;6097.3597772233725;6137.324894261627;4384.320430333303;4386.670999675037;4392.692511524195;4393.648508119343;4410.235905637738;6216.347283535254;6261.27995280544;6318.620882747004;6333.71986085009;6393.232812062536;4434.26834572292;4467.5703774791755;4471.374007638933;4476.932846007313;4542.954570454319;4564.269716845355;4628.5371462853445;4638.257878739386;4638.257878739386;4645.535446455395;5191.922121168185;5196.818111366084;5226.268322434862;5252.474752524793;5268.315119034501;5931.08068249422;5931.584789064724;6107.328193898667;6107.877842443127;6142.78500252489;1506.9773953390709;1531.1425601663104;1535.6314484523857;1537.1315206908062;1537.3850459816163;951.1962391779074;974.1573538888952;990.0446069542926;995.4276291132628;1002.6039714312951;5182.2485739567555;5204.386640141568;5255.76349064293;5274.789008439696;5295.311609490742;5470.769076957653;5507.586930980113;5542.695151766611;5545.72271386429;5576.187738984765;5146.948530514647;5311.920321195185;5323.547498462674;5329.32126380189;5336.946630533645;2938.5160493950843;2988.3713376210017;3004.662924998355;3024.3346463777934;3029.8939537116094;5689.971550142222;5736.483716465538;5775.393583673737;5795.275590551181;5838.32859221195;5303.867403314871;5559.694216818114;5575.330960284792;5642.915356269659;5649.971750141223;5676.801311954062;5721.312212897205;5724.79963201286;5728.911506813692;5844.1525978732;5527.944720552743;5533.8457079465925;5576.721163941867;5832.854178645398;6279.277883043508;6253.1245625613365;6266.216722909637;6281.685915704288;6282.555012347277;6292.433680968735;6341.968290158704;6518.121717578034;6535.477161827138;6554.180727409074;6581.177352830896;4410.29435290352;4437.534058923767;4472.172648060119;4485.730856148642;4485.977570112129;6110.908336375047;6176.81469555914;6327.3988971047675;6434.613923164625;6440.774572889926;6110.7250173741395;6135.202423684892;6160.168377269011;6166.929826314611;6178.548041210402;6052.606580572248;6106.572539922163;6115.480184184395;6144.631322120687;6151;5882.382349853375;6071.362506936708;6098.26199533131;6107.297660769068;6207.782727604512;6280.120783090462;6293.96853015732;6297.716602752978;6308.306086330592;6323.083152942706;6018.939810601838;6055;6090.695465226632;6096.512279017579;6155.076338739063 03:15:30 INFO - PROCESS | 836 | |5;yui.html;839.0099682374795;840.3445312656129;853.5305581929941;934.8364036293649;966.737261741622;17138.914305428472;18539.907300463496;18593;18694.15876285567;18741.437756867297;15434.69130617387;16666.333346666117;16701.49895503137;16752.078635675032;16817.32730690774;882.4396508217264;903.7424334064793;904.3036861616552;906.6056265524518;909.8134882349136;895.5880295064278;900.6577500549782;901.1709227510706;901.3510272603714;902.6705252582825;932.6036434515304;939.1641439119189;940.7412961435591;941.0589410589411;942.8302905477011;932.1144912333243;935.0088905759916;936.0779632062413;939.6523286384047;941.4069136444031;687.0552989639247;688.0779755128102;689.4484412470003;692.1071817355605;692.9930700692979;15569.766453503207;15635.452759153375;15932.12373319467;16008.919955400148;16013.839861601351;14292.928535357256;14825.18461484618;14948.775768363483;14973.1016139032;15203.923980380137;11503.827442588368;12180.208286461351;12665.620031399072;12743.490260389573;12752.936235318857;4051.5948405159543;4129.215449064668;4151.304787944039;4187.91624167518;4245.066085461193;49592;58175;73134.26865731328;84443.57778211132;85677.57161214216;11461.656150315504;11632.709182270342;11800.822987655192;11985.700357491132;12011.399430028463;24239;24457.021719131037;24469;24611.384715382257;24622.507549849262;9571.473568953774;9597.90402095984;9694.61221551144;9718.951405242928;9869.161121304625;4948.505149485095;5054.16606259963;5129.12804823181;5165.845024649267;5353.036453438341;3878;3993.9001524961527;4006.7395619284653;4022.235775202702;4053.5541090480615;725.408791834653;728.366321300472;731.8792399254063;748.8090536913053;749.4341771962243;825.2984962781587;825.405707890318;843.5908584336592;850.4897061763016;852.411835833273;10662.786744265071;10929.688437387564;11163;11570.479328430241;11972.745936189069;775.8293175501381;800.651716503323;800.9479383840148;831.6881169561415;852.3735054734765;5297.576193904479;5553.383644686379;5622.128570071645;5706.942930570641;5849.181114643953;108579;132769.3361533186;135041.32479337737;135519;137954;32470.512942305886;32769;83373;95547;95579.52210239043;76433;77734.61132694414;83874;94302;95453;10859.565617375216;10886.346819190874;11075.169362297698;11304.83042754343;11323.490442930253;51984.14087225239;52706.73646631742;53319.46680533145;55149.44850551443;55383.446165537825;70927.64536177285;78467.21532784599;78842;78908;81262;13458.596242112751;13782.93108534451;14310.785338220143;14566;14653.780193297322;15491;15866.603334916257;16367.67264654724;16814.831851681327;17058;15500;15510.767338489706;16230;16667.66664666724;16908.23912923946;14521.636959076108;14834.703305933604;15024.24878756036;15860.52418427449;16398.344066237216;14984.550463486114;16417.507474775775;16452.670946581242;16539;16586.419475318788;11795.469203885674;11904.76190476203;12167;12193.573224937085;12341.3829308536;11318.717032074264;12836.55072072473;12903.161294515827;12921.483140674267;13409.128406653535 03:15:30 INFO - PROCESS | 836 | __end_tp_report 03:15:30 INFO - PROCESS | 836 | __start_cc_report 03:15:30 INFO - PROCESS | 836 | _x_x_mozilla_cycle_collect,336 03:15:30 INFO - PROCESS | 836 | __end_cc_report 03:15:30 INFO - PROCESS | 836 | __startTimestamp1471428930228__endTimestamp 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | ------- Summary: start ------- 03:15:30 INFO - PROCESS | 836 | Number of tests: 6 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#0] dojo.html Cycles:165 Average:5818.17 Median:6062.55 stddev:674.89 (11.1%) stddev-sans-first:647.60 03:15:30 INFO - PROCESS | 836 | Values: 3307.9 3343.3 3348.3 3366.1 3376.3 5830.0 5839.6 5927.3 5932.5 5938.7 5723.2 5782.7 5841.3 5841.8 5846.2 5179.9 5321.2 5335.3 5365.1 5369.5 5240.0 5251.3 5281.8 5333.4 5381.9 5299.9 5325.8 5328.4 5328.4 5334.4 5355.9 5368.2 5372.4 5387.0 5393.6 5115.1 5184.2 5222.1 5265.9 5266.2 5767.9 5825.6 5825.7 5864.6 5887.7 6229.8 6265.3 6267.5 6271.7 6311.2 6057.9 6130.5 6160.5 6334.1 6336.9 5876.5 5879.4 5888.0 5891.6 5917.2 6415.7 6452.2 6466.2 6485.1 6486.6 5943.4 6097.3 6115.5 6123.9 6191.9 6252.4 6277.4 6296.5 6303.5 6319.3 6280.3 6287.5 6287.7 6292.7 6309.2 6040.6 6122.6 6125.6 6257.0 6260.7 4747.4 4752.2 4775.7 4790.4 4801.2 4224.7 4232.8 4241.0 4241.0 4269.5 5889.8 5924.9 5943.7 5947.6 5978.0 6272.5 6321.8 6323.6 6327.6 6331.2 6063.3 6064.5 6075.2 6075.7 6077.2 5265.4 5343.7 5387.5 5434.9 5480.2 6563.0 6565.4 6573.1 6587.7 6624.6 6234.7 6310.3 6326.0 6335.8 6357.9 6246.0 6400.5 6445.4 6504.8 6572.7 6146.2 6159.8 6170.4 6189.0 6198.6 6267.8 6272.9 6281.3 6303.0 6314.5 5920.2 6039.0 6080.1 6157.3 6182.0 6079.4 6105.2 6112.4 6122.8 6134.4 6041.9 6047.3 6076.1 6079.3 6103.7 5980.6 6096.9 6135.6 6167.4 6176.9 6045.0 6048.7 6053.7 6061.3 6062.5 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#1] ext.html Cycles:180 Average:67947.38 Median:46135.65 stddev:137994.23 (299.1%) stddev-sans-first:138288.64 03:15:30 INFO - PROCESS | 836 | Values: 582.2 637.4 661.7 661.9 697.6 42369.8 47609.3 47656.3 47690.8 47824.5 47938.3 48704.0 48795.8 48844.5 48890.5 9073.8 9199.0 9234.7 9257.2 9263.6 9089.9 9204.6 9239.7 9247.2 9268.9 9295.0 9305.1 9322.0 9341.3 9364.5 9105.3 9165.8 9247.2 9267.3 9275.4 9122.8 9168.5 9174.2 9180.7 9188.1 44874.3 44977.1 45196.1 45573.8 45671.0 4156.4 4209.7 4444.6 4560.5 4697.2 35586.5 36435.5 36563.8 36572.5 36903.8 4101.8 4103.2 4157.7 4166.0 4277.1 403286.0 406573.0 407496.0 408671.0 409664.0 39435.0 70677.3 70846.3 71315.6 71493.6 39582.4 41055.6 41512.4 41545.0 41717.8 16126.5 16292.8 16301.2 16301.9 16302.8 12188.8 12197.0 12256.2 12267.4 12287.3 9258.4 9289.8 9308.6 9329.4 9349.3 3514.4 3516.4 3549.3 3576.1 3576.4 1083.3 1094.3 1125.7 1152.1 1170.9 36203.0 36333.1 36368.0 36422.0 36733.6 1197.2 1255.6 1267.1 1268.2 1332.2 18396.9 18520.2 18687.3 18690.9 18754.2 593501.0 595379.0 596219.0 598260.0 601608.0 66872.3 67093.7 67315.7 67373.3 67723.0 1426.6 1470.8 1472.9 1479.7 1499.1 35947.9 36101.2 36169.6 36463.5 36571.5 57865.1 58929.0 59184.4 59368.0 59420.1 528574.0 534422.0 536093.0 536694.0 537562.0 31993.8 31997.0 32158.8 32437.4 32470.7 55269.4 55543.0 55574.7 58276.5 58728.4 46600.3 48670.5 48710.5 48953.3 49240.3 48389.3 48592.8 48696.5 48808.5 49205.0 46975.0 48044.0 48062.3 48196.8 48367.5 38508.4 40683.2 40923.4 41123.2 41804.6 31518.4 31617.7 31884.2 31894.4 32438.0 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#2] jquery.html Cycles:180 Average:30234.92 Median:415.87 stddev:86404.16 (20776.9%) stddev-sans-first:86617.51 03:15:30 INFO - PROCESS | 836 | Values: 403.7 409.2 414.5 417.2 431.5 18776.8 20036.7 20181.9 20470.9 20894.9 19618.3 19791.8 20380.2 20505.2 20633.6 5164.1 5392.3 5404.5 5462.8 5477.7 5398.4 5425.1 5823.2 5865.7 5884.8 6017.9 6019.3 6029.9 6030.3 6044.4 6025.2 6038.0 6059.5 6076.7 6077.5 5343.1 5420.8 5460.1 5472.6 5481.8 14903.4 15242.5 15305.4 15370.3 22371.3 2325.5 2426.5 2482.8 2627.2 3111.8 10148.8 10223.8 10255.3 10338.9 10568.0 1937.7 2047.0 2049.5 2056.0 2104.7 78294.0 83591.0 86156.0 87812.0 88426.0 11340.9 11424.8 11603.7 11611.7 11802.9 16235.8 16266.2 16273.8 16370.9 16605.8 8486.0 8501.8 8818.2 8851.2 8884.5 8472.1 8604.0 8622.6 8667.9 8778.0 4924.7 5043.3 5048.8 5051.7 5126.0 1965.7 2023.3 2030.7 2039.6 2045.9 478.7 479.7 901.9 964.9 1014.4 12691.4 13162.6 13298.2 13337.6 13467.7 502.0 509.5 514.2 528.6 537.2 6038.3 6757.2 6821.5 6952.3 7038.6 483101.0 517046.0 534114.0 539273.0 539746.0 89752.6 94520.0 101861.0 103608.5 106839.5 1079.5 1113.1 1124.2 1134.9 1141.4 18768.8 18927.3 19224.5 19371.5 19391.2 34745.8 44464.0 44534.8 45358.5 45712.8 58907.0 59375.7 62767.7 68597.7 68800.0 8556.0 9013.1 9052.9 9146.6 9368.9 13596.4 14161.9 14424.2 14546.6 14590.5 11972.0 12098.8 12231.3 12592.5 12788.4 8755.4 12242.5 12336.7 12669.0 12716.6 12421.4 12426.4 12882.5 12943.5 13201.1 8606.7 8655.7 8701.5 8785.3 8797.9 8833.8 11797.9 12087.4 12361.0 12565.5 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#3] mootools.html Cycles:180 Average:6536.34 Median:4361.46 stddev:3774.68 (86.5%) stddev-sans-first:3766.78 03:15:30 INFO - PROCESS | 836 | Values: 1565.5 1595.0 1746.0 1822.1 1823.5 8726.7 9395.4 9478.7 10155.2 10167.5 9456.9 9872.2 9887.6 9905.5 9913.6 2551.3 2592.9 2596.4 2597.3 2602.4 2517.9 2595.9 2597.0 2597.7 2598.6 2541.2 2546.6 2577.9 2598.8 2604.4 2452.8 2459.0 2465.9 2472.2 2495.5 2470.1 2477.2 2485.8 2504.6 2535.5 9930.4 10085.2 10093.1 10094.4 10121.8 5692.6 5814.4 5815.2 5826.3 5826.3 3373.1 3406.3 3477.0 3485.3 3592.3 1043.8 1062.6 1072.3 1083.0 1098.1 13942.4 14008.8 14100.4 14121.2 14128.3 4863.9 4958.9 5096.4 5167.5 5180.8 11801.8 11900.9 11913.7 11924.9 11939.9 5869.9 5895.1 5903.5 5908.8 5914.3 4661.6 5104.1 5219.5 5233.5 5422.2 4258.8 4320.3 4402.6 4469.0 4472.2 1307.8 1322.2 1334.4 1339.2 1358.3 929.2 978.3 1040.6 1056.3 1132.9 6567.5 6700.2 6974.9 6986.2 7029.1 1001.8 1010.5 1028.6 1046.2 1054.2 4748.8 4922.1 4922.8 4937.9 4953.8 11560.3 11925.6 12214.8 12529.4 12581.4 12297.8 12311.6 12339.5 12367.0 12402.4 8847.2 9114.9 9146.1 9155.5 9163.2 6911.8 7059.4 7136.1 7172.2 7247.3 11255.9 11272.8 11429.8 11568.1 11654.4 11321.8 11618.5 11636.8 11884.0 11888.2 7747.6 8275.9 8419.7 8692.5 8814.9 9777.0 9787.5 9807.8 9865.8 9868.2 8232.7 8421.1 8650.7 8656.8 8748.2 8583.9 8709.4 8713.1 8735.9 8827.5 8121.9 8157.9 8172.4 8176.0 8192.1 5876.1 5912.6 6033.0 6043.7 6073.4 6017.8 6077.7 6088.6 6201.6 6217.5 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#4] prototype.html Cycles:180 Average:5016.21 Median:5576.45 stddev:1469.68 (26.4%) stddev-sans-first:1431.23 03:15:30 INFO - PROCESS | 836 | Values: 337.3 347.9 350.7 351.2 351.6 5657.3 5719.0 5854.6 5870.6 5888.3 5713.9 5731.9 5772.2 5773.9 5780.0 4538.8 4561.7 4564.3 4568.8 4579.7 4481.0 4518.7 4519.6 4527.2 4544.5 4442.8 4447.5 4460.8 4461.5 4492.8 4475.6 4503.9 4511.3 4515.8 4536.9 3871.9 3979.5 3986.2 4020.8 4029.4 5595.7 5636.4 5637.7 5688.5 5697.2 5200.5 5239.8 5254.5 5255.8 5259.4 5944.0 6039.6 6074.8 6097.4 6137.3 4384.3 4386.7 4392.7 4393.6 4410.2 6216.3 6261.3 6318.6 6333.7 6393.2 4434.3 4467.6 4471.4 4476.9 4543.0 4564.3 4628.5 4638.3 4638.3 4645.5 5191.9 5196.8 5226.3 5252.5 5268.3 5931.1 5931.6 6107.3 6107.9 6142.8 1507.0 1531.1 1535.6 1537.1 1537.4 951.2 974.2 990.0 995.4 1002.6 5182.2 5204.4 5255.8 5274.8 5295.3 5470.8 5507.6 5542.7 5545.7 5576.2 5146.9 5311.9 5323.5 5329.3 5336.9 2938.5 2988.4 3004.7 3024.3 3029.9 5690.0 5736.5 5775.4 5795.3 5838.3 5303.9 5559.7 5575.3 5642.9 5650.0 5676.8 5721.3 5724.8 5728.9 5844.2 5527.9 5533.8 5576.7 5832.9 6279.3 6253.1 6266.2 6281.7 6282.6 6292.4 6342.0 6518.1 6535.5 6554.2 6581.2 4410.3 4437.5 4472.2 4485.7 4486.0 6110.9 6176.8 6327.4 6434.6 6440.8 6110.7 6135.2 6160.2 6166.9 6178.5 6052.6 6106.6 6115.5 6144.6 6151.0 5882.4 6071.4 6098.3 6107.3 6207.8 6280.1 6294.0 6297.7 6308.3 6323.1 6018.9 6055.0 6090.7 6096.5 6155.1 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - PROCESS | 836 | [#5] yui.html Cycles:180 Average:21130.03 Median:4036.92 stddev:29805.16 (738.3%) stddev-sans-first:29849.83 03:15:30 INFO - PROCESS | 836 | Values: 839.0 840.3 853.5 934.8 966.7 17138.9 18539.9 18593.0 18694.2 18741.4 15434.7 16666.3 16701.5 16752.1 16817.3 882.4 903.7 904.3 906.6 909.8 895.6 900.7 901.2 901.4 902.7 932.6 939.2 940.7 941.1 942.8 932.1 935.0 936.1 939.7 941.4 687.1 688.1 689.4 692.1 693.0 15569.8 15635.5 15932.1 16008.9 16013.8 14292.9 14825.2 14948.8 14973.1 15203.9 11503.8 12180.2 12665.6 12743.5 12752.9 4051.6 4129.2 4151.3 4187.9 4245.1 49592.0 58175.0 73134.3 84443.6 85677.6 11461.7 11632.7 11800.8 11985.7 12011.4 24239.0 24457.0 24469.0 24611.4 24622.5 9571.5 9597.9 9694.6 9719.0 9869.2 4948.5 5054.2 5129.1 5165.8 5353.0 3878.0 3993.9 4006.7 4022.2 4053.6 725.4 728.4 731.9 748.8 749.4 825.3 825.4 843.6 850.5 852.4 10662.8 10929.7 11163.0 11570.5 11972.7 775.8 800.7 800.9 831.7 852.4 5297.6 5553.4 5622.1 5706.9 5849.2 108579.0 132769.3 135041.3 135519.0 137954.0 32470.5 32769.0 83373.0 95547.0 95579.5 76433.0 77734.6 83874.0 94302.0 95453.0 10859.6 10886.3 11075.2 11304.8 11323.5 51984.1 52706.7 53319.5 55149.4 55383.4 70927.6 78467.2 78842.0 78908.0 81262.0 13458.6 13782.9 14310.8 14566.0 14653.8 15491.0 15866.6 16367.7 16814.8 17058.0 15500.0 15510.8 16230.0 16667.7 16908.2 14521.6 14834.7 15024.2 15860.5 16398.3 14984.6 16417.5 16452.7 16539.0 16586.4 11795.5 11904.8 12167.0 12193.6 12341.4 11318.7 12836.6 12903.2 12921.5 13409.1 03:15:30 INFO - PROCESS | 836 | -------- Summary: end -------- 03:15:30 INFO - PROCESS | 836 | 03:15:30 INFO - TEST-INFO | 836: exit 0 03:15:30 INFO - TEST-OK | dromaeo_css | took 1111082ms 03:15:30 INFO - TEST-START | kraken 03:15:30 INFO - operating with platform_type : linux_ 03:15:30 INFO - Initialising browser for kraken test... 03:15:30 INFO - TEST-INFO | started process 1112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDipizk/profile http://localhost:45646/getInfo.html) 03:15:35 INFO - PROCESS | 1112 | __metrics Screen width/height:1600/1200 03:15:35 INFO - PROCESS | 1112 | colorDepth:24 03:15:35 INFO - PROCESS | 1112 | Browser inner width/height: 1024/697 03:15:35 INFO - PROCESS | 1112 | __metrics 03:15:36 ERROR - PROCESS | 1112 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:15:36 INFO - TEST-INFO | 1112: exit 0 03:15:36 INFO - Browser initialized. 03:15:36 INFO - Running cycle 1/1 for kraken test... 03:15:36 INFO - TEST-INFO | started process 1304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDipizk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:48 INFO - PROCESS | 1304 | RSS: Main: 152657920 03:15:48 INFO - PROCESS | 1304 | 03:15:51 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:52 INFO - PROCESS | 1304 | RSS: Main: 158003200 03:15:52 INFO - PROCESS | 1304 | 03:15:54 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-dft) 03:15:55 INFO - PROCESS | 1304 | RSS: Main: 156266496 03:15:55 INFO - PROCESS | 1304 | 03:15:58 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-fft) 03:15:58 INFO - PROCESS | 1304 | RSS: Main: 157093888 03:15:58 INFO - PROCESS | 1304 | 03:16:00 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45646/tests/kraken/driver.html?testName=audio-oscillator) 03:16:01 INFO - PROCESS | 1304 | RSS: Main: 156844032 03:16:01 INFO - PROCESS | 1304 | 03:16:03 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:04 INFO - PROCESS | 1304 | RSS: Main: 156676096 03:16:04 INFO - PROCESS | 1304 | 03:16:07 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-darkroom) 03:16:07 INFO - PROCESS | 1304 | RSS: Main: 155910144 03:16:07 INFO - PROCESS | 1304 | 03:16:11 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45646/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:12 INFO - PROCESS | 1304 | RSS: Main: 154345472 03:16:12 INFO - PROCESS | 1304 | 03:16:14 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45646/tests/kraken/driver.html?testName=json-parse-financial) 03:16:15 INFO - PROCESS | 1304 | RSS: Main: 156356608 03:16:15 INFO - PROCESS | 1304 | 03:16:16 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:17 INFO - PROCESS | 1304 | RSS: Main: 157163520 03:16:17 INFO - PROCESS | 1304 | 03:16:19 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:19 INFO - PROCESS | 1304 | RSS: Main: 157028352 03:16:19 INFO - PROCESS | 1304 | 03:16:21 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:22 INFO - PROCESS | 1304 | RSS: Main: 156786688 03:16:22 INFO - PROCESS | 1304 | 03:16:25 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:25 INFO - PROCESS | 1304 | RSS: Main: 157294592 03:16:25 INFO - PROCESS | 1304 | 03:16:28 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:29 INFO - PROCESS | 1304 | RSS: Main: 157253632 03:16:29 INFO - PROCESS | 1304 | 03:16:30 INFO - PROCESS | 1304 | Cycle 1(1): loaded http://localhost:45646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45646/tests/kraken/driver.html?testName=ai-astar) 03:16:31 INFO - PROCESS | 1304 | RSS: Main: 157839360 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | __start_tp_report 03:16:31 INFO - PROCESS | 1304 | _x_x_mozilla_page_load 03:16:31 INFO - PROCESS | 1304 | _x_x_mozilla_page_load_details 03:16:31 INFO - PROCESS | 1304 | |i|pagename|runs| 03:16:31 INFO - PROCESS | 1304 | |0;ai-astar;99;110;104;109;111;112;109;110;109;111 03:16:31 INFO - PROCESS | 1304 | |1;audio-beat-detection;143;120;140;171;120;148;143;121;172;116 03:16:31 INFO - PROCESS | 1304 | |2;audio-dft;161;161;162;162;161;165;162;162;160;163 03:16:31 INFO - PROCESS | 1304 | |3;audio-fft;74;75;76;184;76;75;75;76;180;76 03:16:31 INFO - PROCESS | 1304 | |4;audio-oscillator;83;82;156;84;86;83;144;85;83;136 03:16:31 INFO - PROCESS | 1304 | |5;imaging-gaussian-blur;118;118;117;116;118;117;117;118;117;117 03:16:31 INFO - PROCESS | 1304 | |6;imaging-darkroom;147;147;148;148;147;148;147;147;147;148 03:16:31 INFO - PROCESS | 1304 | |7;imaging-desaturate;95;96;95;96;96;95;95;95;95;95 03:16:31 INFO - PROCESS | 1304 | |8;json-parse-financial;50;54;49;50;51;53;59;51;51;50 03:16:31 INFO - PROCESS | 1304 | |9;json-stringify-tinderbox;63;59;59;59;60;60;60;60;60;59 03:16:31 INFO - PROCESS | 1304 | |10;stanford-crypto-aes;74;72;73;72;72;71;78;73;76;80 03:16:31 INFO - PROCESS | 1304 | |11;stanford-crypto-ccm;119;128;122;119;118;121;118;121;152;119 03:16:31 INFO - PROCESS | 1304 | |12;stanford-crypto-pbkdf2;165;154;151;152;154;154;150;153;151;153 03:16:31 INFO - PROCESS | 1304 | |13;stanford-crypto-sha256-iterative;64;62;63;61;62;63;60;61;61;60 03:16:31 INFO - PROCESS | 1304 | __end_tp_report 03:16:31 INFO - PROCESS | 1304 | __start_cc_report 03:16:31 INFO - PROCESS | 1304 | _x_x_mozilla_cycle_collect,845 03:16:31 INFO - PROCESS | 1304 | __end_cc_report 03:16:31 INFO - PROCESS | 1304 | __startTimestamp1471428991010__endTimestamp 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | ------- Summary: start ------- 03:16:31 INFO - PROCESS | 1304 | Number of tests: 14 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:2.30 03:16:31 INFO - PROCESS | 1304 | Values: 99.0 110.0 104.0 109.0 111.0 112.0 109.0 110.0 109.0 111.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:143.00 stddev:20.55 (14.4%) stddev-sans-first:21.75 03:16:31 INFO - PROCESS | 1304 | Values: 143.0 120.0 140.0 171.0 120.0 148.0 143.0 121.0 172.0 116.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 03:16:31 INFO - PROCESS | 1304 | Values: 161.0 161.0 162.0 162.0 161.0 165.0 162.0 162.0 160.0 163.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#3] audio-fft Cycles:10 Average:96.70 Median:75.50 stddev:44.97 (59.6%) stddev-sans-first:46.94 03:16:31 INFO - PROCESS | 1304 | Values: 74.0 75.0 76.0 184.0 76.0 75.0 75.0 76.0 180.0 76.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:83.00 stddev:30.16 (36.3%) stddev-sans-first:31.18 03:16:31 INFO - PROCESS | 1304 | Values: 83.0 82.0 156.0 84.0 86.0 83.0 144.0 85.0 83.0 136.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:16:31 INFO - PROCESS | 1304 | Values: 118.0 118.0 117.0 116.0 118.0 117.0 117.0 118.0 117.0 117.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:16:31 INFO - PROCESS | 1304 | Values: 147.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 148.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:16:31 INFO - PROCESS | 1304 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.00 stddev:2.94 (5.8%) stddev-sans-first:3.04 03:16:31 INFO - PROCESS | 1304 | Values: 50.0 54.0 49.0 50.0 51.0 53.0 59.0 51.0 51.0 50.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.20 (2.0%) stddev-sans-first:0.53 03:16:31 INFO - PROCESS | 1304 | Values: 63.0 59.0 59.0 59.0 60.0 60.0 60.0 60.0 60.0 59.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:73.50 stddev:2.96 (4.0%) stddev-sans-first:3.14 03:16:31 INFO - PROCESS | 1304 | Values: 74.0 72.0 73.0 72.0 72.0 71.0 78.0 73.0 76.0 80.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:121.00 stddev:10.37 (8.6%) stddev-sans-first:10.86 03:16:31 INFO - PROCESS | 1304 | Values: 119.0 128.0 122.0 119.0 118.0 121.0 118.0 121.0 152.0 119.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:153.50 stddev:4.22 (2.7%) stddev-sans-first:1.51 03:16:31 INFO - PROCESS | 1304 | Values: 165.0 154.0 151.0 152.0 154.0 154.0 150.0 153.0 151.0 153.0 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - PROCESS | 1304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.13 03:16:31 INFO - PROCESS | 1304 | Values: 64.0 62.0 63.0 61.0 62.0 63.0 60.0 61.0 61.0 60.0 03:16:31 INFO - PROCESS | 1304 | -------- Summary: end -------- 03:16:31 INFO - PROCESS | 1304 | 03:16:31 INFO - TEST-INFO | 1304: exit 0 03:16:31 INFO - TEST-OK | kraken | took 60937ms 03:16:31 INFO - SUITE-END | took 1172s 03:16:32 INFO - Completed test suite (00:19:32) 03:16:32 INFO - javascript benchmark 03:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7724.199195202403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.9007629771104, 3343.2979074394375, 3348.2968576598914, 3366.057503898909, 3376.307856889338, 5830.038043722786, 5839.6496210227415, 5927.318358388787, 5932.466078052975, 5938.673372964486, 5723.198752174689, 5782.710864456782, 5841.299044114701, 5841.824745257639, 5846.23998880145, 5179.870503237412, 5321.175217841241, 5335.279737235482, 5365.141577347626, 5369.463053694639, 5240.030594340059, 5251.264822924793, 5281.841544753664, 5333.386660534049, 5381.919271210935, 5299.947000529984, 5325.7603407846545, 5328.387235467912, 5328.413874473805, 5334.386545547253, 5355.9196612050655, 5368.194770784394, 5372.409035006146, 5387.0, 5393.622446428752, 5115.104856650109, 5184.248283998799, 5222.112240919053, 5265.921011184835, 5266.210068489719, 5767.942320576783, 5825.592208545403, 5825.679587622679, 5864.648121112747, 5887.705614719247, 6229.750809967596, 6265.310815810257, 6267.4672652824565, 6271.655058971754, 6311.211098612674, 6057.878842423171, 6130.459285710746, 6160.537959652999, 6334.113224148623, 6336.873262534724, 5876.500497457721, 5879.353271140171, 5888.028475301528, 5891.617044892068, 5917.171595976567, 6415.67921603918, 6452.161219041494, 6466.224053113562, 6485.092087107809, 6486.643234622141, 5943.375945525658, 6097.2683278006925, 6115.4801841843055, 6123.908141377883, 6191.907121393093, 6252.374762523711, 6277.403646653561, 6296.527760417987, 6303.527235457359, 6319.304876463585, 6280.2777680566405, 6287.49700023997, 6287.685615719196, 6292.748290068437, 6309.179806625201, 6040.637561746309, 6122.550631082941, 6125.632462052291, 6257.0, 6260.686965651699, 4747.430308362949, 4752.239641657318, 4775.73733444657, 4790.4251489821445, 4801.207800712913, 4224.704270701083, 4232.788360581959, 4240.978795106004, 4241.045764702917, 4269.530351661315, 5889.793857214977, 5924.851878702981, 5943.673097979567, 5947.583669143205, 5978.04351303798, 6272.498200143978, 6321.810345689637, 6323.557350985387, 6327.588706734047, 6331.176946996861, 6063.272407311063, 6064.514838812973, 6075.2405949256345, 6075.665838378844, 6077.179580756541, 5265.420803711589, 5343.7060961647485, 5387.46125387466, 5434.864128396822, 5480.177973304037, 6563.0, 6565.409113179837, 6573.079768832367, 6587.736490540325, 6624.635645039472, 6234.719437625408, 6310.2743184534365, 6326.0, 6335.809925702236, 6357.93642063592, 6246.031865060922, 6400.45596124316, 6445.419912207736, 6504.804855854332, 6572.737090516326, 6146.200993870947, 6159.753609855735, 6170.382961703794, 6189.0, 6198.597091189058, 6267.843303917439, 6272.937270627235, 6281.309056003744, 6302.968485157545, 6314.494840412848, 5920.200772895776, 6039.0, 6080.087986801838, 6157.291911430243, 6182.041783523561, 6079.392060794062, 6105.17580126695, 6112.38876112403, 6122.764110201883, 6134.355892631388, 6041.879162416815, 6047.334793172836, 6076.149339092619, 6079.270487541523, 6103.664298463627, 5980.551458640706, 6096.8780624388155, 6135.601185922901, 6167.352427994996, 6176.876462470816, 6045.0, 6048.697565121638, 6053.667048312209, 6061.333253342217, 6062.5453091019235], "value": 5771.40037082404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1675004743215, 637.4135795068537, 661.7253839656541, 661.864317814848, 697.5570512724419, 42369.78815105924, 47609.285860712116, 47656.285155722646, 47690.76154619222, 47824.52175478244, 47938.280925786145, 48704.0, 48795.75602121993, 48844.51155488444, 48890.51109488904, 9073.773155671111, 9199.0, 9234.722958311262, 9257.213136883372, 9263.6294548218, 9089.909100909006, 9204.631814727403, 9239.722808315728, 9247.21398681113, 9268.860967085466, 9295.0, 9305.11601397866, 9321.953390233073, 9341.346105772598, 9364.531773411301, 9105.317101217435, 9165.770855728626, 9247.167754902091, 9267.25861931044, 9275.397099188565, 9122.817543649157, 9168.541572921395, 9174.174324310845, 9180.678676246365, 9188.127127922837, 44874.32688509675, 44977.10045799066, 45196.09607807858, 45573.77213113946, 45671.0, 4156.397322388237, 4209.7474151551005, 4444.599986001275, 4560.521145279764, 4697.201475749097, 35586.466203006974, 36435.453468198, 36563.81718091419, 36572.451413228824, 36903.81548092242, 4101.753894766293, 4103.158852435274, 4157.667386609064, 4166.0, 4277.123189746095, 403286.0, 406572.99999999703, 407496.0, 408671.0, 409664.0, 39435.0, 70677.2932270681, 70846.29153708398, 71315.64342178256, 71493.64253178805, 39582.406263906065, 41055.589444105775, 41512.377314339705, 41545.0, 41717.79141104275, 16126.516204513884, 16292.755608665879, 16301.184940752915, 16301.91849040771, 16302.83697163037, 12188.81716774249, 12197.024238060934, 12256.203346782431, 12267.386630668609, 12287.262764234174, 9258.444493330422, 9289.814203715889, 9308.581113849894, 9329.44023358587, 9349.252059835197, 3514.3674138655288, 3516.4373700207843, 3549.272399158218, 3576.1059735066233, 3576.40989236773, 1083.3445765311874, 1094.2887123369715, 1125.7298248420484, 1152.1071169843437, 1170.9063274937985, 36203.0, 36333.0916727084, 36368.0, 36422.0, 36733.63266367302, 1197.245735186844, 1255.604484587352, 1267.0623738433676, 1268.1820225954393, 1332.2073366347008, 18396.908015459838, 18520.16659250337, 18687.252509899452, 18690.906545467187, 18754.1560629772, 593501.0, 595379.0, 596219.0, 598260.0, 601608.0, 66872.33127668759, 67093.664531678, 67315.66342168258, 67373.32626673768, 67723.0, 1426.5934208750457, 1470.8161479815024, 1472.8527147285185, 1479.6522817137964, 1499.1005396761855, 35947.87801109749, 36101.23071243583, 36169.55352770053, 36463.45304820483, 36571.45142822913, 57865.13202301884, 58929.0, 59184.40815591789, 59368.0, 59420.10869837042, 528574.0, 534422.0, 536093.0, 536694.0, 537562.0, 31993.840030799696, 31997.0, 32158.839205803823, 32437.35125297528, 32470.675293246764, 55269.44730552804, 55543.0, 55574.72212639073, 58276.54308642318, 58728.41271587229, 46600.30099548577, 48670.5132948666, 48710.512894872016, 48953.265701015225, 49240.26139607837, 48389.27416088832, 48592.75703621459, 48696.5130348692, 48808.51191488039, 49205.0, 46975.0, 48044.0, 48062.27906581334, 48196.7590162047, 48367.5163248363, 38508.42237366498, 40683.18633627252, 40923.38614920838, 41123.181183974724, 41804.58195418007, 31518.369632606762, 31617.683823161475, 31884.202894927814, 31894.36211275715, 32438.0], "value": 20955.871863097313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.69117625016884, 409.2183928696187, 414.52122798168114, 417.2135524536248, 431.45851955795473, 18776.812231877695, 20036.69944950827, 20181.88999605023, 20470.89764551177, 20894.89552552239, 19618.313359032436, 19791.802081979175, 20380.184792608314, 20505.17979280827, 20633.587328253427, 5164.096283150452, 5392.299001129848, 5404.513593776559, 5462.781488740446, 5477.67133971961, 5398.352197736258, 5425.050616142179, 5823.213866128082, 5865.706714664249, 5884.794032208873, 6017.939820601781, 6019.277686677605, 6029.909551356711, 6030.33666296707, 6044.395560443964, 6025.246844144482, 6037.969810150943, 6059.454649081582, 6076.696165191723, 6077.544184186204, 5343.118385466393, 5420.783168673248, 5460.071787796044, 5472.5621950243885, 5481.780728770845, 14903.403863845433, 15242.466513671969, 15305.387784488606, 15370.308336124901, 22371.32886013422, 2325.4883925536355, 2426.5146970605774, 2482.8013758899247, 2627.1987043951585, 3111.7821752477334, 10148.797024059477, 10223.846642300372, 10255.282130250886, 10338.896611033944, 10568.0, 1937.7384053152784, 2046.9897650511653, 2049.549099198174, 2056.0028386232666, 2104.7474303083577, 78294.0, 83591.0, 86156.0, 87812.0, 88425.99999999936, 11340.886591133984, 11424.828627570592, 11603.720307260344, 11611.65165045033, 11802.88197118035, 16235.756463653055, 16266.18669066542, 16273.755893661604, 16370.918145409196, 16605.750913736305, 8485.95757021211, 8501.829963400698, 8818.206361427503, 8851.203391694778, 8884.511351875579, 8472.068072512142, 8603.956980215184, 8622.611982460805, 8667.869981950276, 8777.956110219537, 4924.655274130848, 5043.268726034705, 5048.823291184791, 5051.671641343374, 5125.974370128126, 1965.7051442283487, 2023.261509549004, 2030.6953956906582, 2039.6022775558624, 2045.877247365163, 478.6601512925862, 479.70498143642106, 901.9278457723498, 964.9048330145196, 1014.4420568687193, 12691.428885700165, 13162.60512184636, 13298.202107873558, 13337.599872003855, 13467.730645387233, 501.9648624596316, 509.47015104291864, 514.2081194959795, 528.5586535243038, 537.1841441477176, 6038.275406951194, 6757.155355580552, 6821.488388370892, 6952.304769523007, 7038.577685338793, 483101.0, 517046.0, 534114.0, 539273.0, 539746.0, 89752.5512372434, 94520.0, 101861.0, 103608.48195758973, 106839.46580267049, 1079.4818487126224, 1113.1095123900848, 1124.201816710145, 1134.9375784331776, 1141.3779490177874, 18768.812311876707, 18927.337543185924, 19224.519387015436, 19371.515712106746, 19391.2243510258, 34745.8262708695, 44464.0, 44534.77732611316, 45358.54641453675, 45712.771436142604, 58907.0, 59375.70312148412, 62767.6861615689, 68597.65701171462, 68800.0, 8555.957220213859, 9013.143751343612, 9052.90947090547, 9146.57902360543, 9368.906310937076, 13596.388162532907, 14161.858381416054, 14424.206668633326, 14546.636334091309, 14590.489332873298, 11972.0, 12098.818517722066, 12231.327276999851, 12592.496300148257, 12788.424520896397, 8755.387122901337, 12242.510299587917, 12336.691582710504, 12669.0, 12716.618501444971, 12421.441035153259, 12426.440810163745, 12882.549110781078, 12943.482260709843, 13201.141925774795, 8606.698765543177, 8655.6970506032, 8701.521416322163, 8785.25325347327, 8797.85627868373, 8833.779155520906, 11797.88202117968, 12087.39563021863, 12361.0, 12565.497380104693], "value": 9066.404977808257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.483390481141, 1594.96012599685, 1745.9563510912226, 1822.0525326830057, 1823.498537902076, 8726.738197854074, 9395.389299695524, 9478.715638530837, 10155.238357123217, 10167.542460589273, 9456.91245506767, 9872.16086632637, 9887.555060022298, 9905.455199963999, 9913.553890074963, 2551.272887227136, 2592.857392843393, 2596.363890846745, 2597.3246955791537, 2602.3754298968206, 2517.874106294687, 2595.9221223363234, 2596.9610455843176, 2597.6623039005, 2598.649182360376, 2541.186820217531, 2546.567083595793, 2577.90977315794, 2598.753118453744, 2604.387968827324, 2452.828302018859, 2458.9754102459015, 2465.8767061647027, 2472.208893154191, 2495.5258500884956, 2470.1354525915967, 2477.2444404456633, 2485.801135909123, 2504.586743187372, 2535.4802265535523, 9930.404175749478, 10085.243606729451, 10093.142082922886, 10094.444805535693, 10121.848172277421, 5692.601517893708, 5814.360420353758, 5815.244018277597, 5826.271716035496, 5826.329972053183, 3373.1229880231317, 3406.267652454709, 3477.0, 3485.3203625292826, 3592.281543691246, 1043.8184195032418, 1062.5696592879897, 1072.3190773858578, 1082.983755243672, 1098.1489345757102, 13942.442302307896, 14008.789868151986, 14100.365483553265, 14121.15273083608, 14128.293585320796, 4863.927041094386, 4958.9008219835405, 5096.362954630671, 5167.457416971239, 5180.844574662766, 11801.763964720829, 11900.880991189977, 11913.70215744596, 11924.88075119255, 11939.88060119405, 5869.882602347929, 5895.056790913433, 5903.498202652822, 5908.822735317947, 5914.349421563625, 4661.603763680057, 5104.05574968632, 5219.451957544479, 5233.502817232356, 5422.240886275925, 4258.787060646955, 4320.287152619845, 4402.625776808943, 4469.039156581351, 4472.239719247736, 1307.7972914198124, 1322.2463195978391, 1334.4328660319325, 1339.2031741114022, 1358.3140514040545, 929.1823195587839, 978.2516374973151, 1040.625374865048, 1056.2975621211963, 1132.869719982196, 6567.474602031826, 6700.199297712826, 6974.860502789916, 6986.196587392414, 7029.086218791626, 1001.7996400719885, 1010.4644538394663, 1028.5834237133972, 1046.1682962045193, 1054.177741361739, 4748.810047598126, 4922.1140194765285, 4922.803087876517, 4937.925931111036, 4953.8018479261145, 11560.306381616962, 11925.582604608971, 12214.755704885853, 12529.43617537213, 12581.37093145339, 12297.815532767016, 12311.630651080482, 12339.50641974329, 12367.0, 12402.379881006094, 8847.159519845605, 9114.908850911539, 9146.131117543822, 9155.45067295951, 9163.175314221751, 6911.7926462206215, 7059.399951004222, 7136.143662760502, 7172.175199852084, 7247.275272472922, 11255.887441125484, 11272.830907536558, 11429.828552571551, 11568.132390070947, 11654.359010254517, 11321.830172547254, 11618.535258589562, 11636.825447618123, 11884.049276058067, 11888.167828252286, 7747.573883436465, 8275.875861862198, 8419.663213471393, 8692.52191129494, 8814.86777698348, 9776.951115244377, 9787.46168960714, 9807.803843923224, 9865.802683946424, 9868.210543156674, 8232.711855085283, 8421.115782842959, 8650.740477785677, 8656.78358041054, 8748.2126608603, 8583.871241931502, 8709.390342675952, 8713.085126061926, 8735.91264087351, 8827.514486703292, 8121.878171827546, 8157.918420815716, 8172.42793004484, 8175.959120204361, 8192.057913340042, 5876.08920617305, 5912.5861189718025, 6032.969835150971, 6043.728032238648, 6073.423024812636, 6017.849553761191, 6077.726502307319, 6088.6042407243385, 6201.627902325875, 6217.502599792097], "value": 5164.022190315015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.27822459935743, 347.9301148966927, 350.73694728953285, 351.17123588331543, 351.5640605648994, 5657.264555607765, 5718.971405142979, 5854.560907931901, 5870.647761134335, 5888.263967004124, 5713.857153571163, 5731.856703582413, 5772.163036359725, 5773.913391299134, 5779.971100144504, 4538.7503687297185, 4561.726296422209, 4564.338170965217, 4568.771561421932, 4579.702319349249, 4481.0, 4518.661100417482, 4519.5932366087045, 4527.20773864574, 4544.477385100706, 4442.756408013965, 4447.510773814878, 4460.776961151945, 4461.531539188387, 4492.820287188509, 4475.597196252336, 4503.864884053483, 4511.323301504801, 4515.796789144496, 4536.8638940831825, 3871.9032024199337, 3979.5423526294267, 3986.222686576119, 4020.7885662885296, 4029.435878976946, 5595.677793715603, 5636.351819540764, 5637.7181140942785, 5688.459596338341, 5697.1739097831, 5200.479952004807, 5239.816606418795, 5254.474552544753, 5255.789768409298, 5259.3951695555115, 5944.0, 6039.5772295939305, 6074.817755467343, 6097.3597772233725, 6137.324894261627, 4384.320430333303, 4386.670999675037, 4392.692511524195, 4393.648508119343, 4410.235905637738, 6216.347283535254, 6261.27995280544, 6318.620882747004, 6333.71986085009, 6393.232812062536, 4434.26834572292, 4467.5703774791755, 4471.374007638933, 4476.932846007313, 4542.954570454319, 4564.269716845355, 4628.5371462853445, 4638.257878739386, 4638.257878739386, 4645.535446455395, 5191.922121168185, 5196.818111366084, 5226.268322434862, 5252.474752524793, 5268.315119034501, 5931.08068249422, 5931.584789064724, 6107.328193898667, 6107.877842443127, 6142.78500252489, 1506.9773953390709, 1531.1425601663104, 1535.6314484523857, 1537.1315206908062, 1537.3850459816163, 951.1962391779074, 974.1573538888952, 990.0446069542926, 995.4276291132628, 1002.6039714312951, 5182.2485739567555, 5204.386640141568, 5255.76349064293, 5274.789008439696, 5295.311609490742, 5470.769076957653, 5507.586930980113, 5542.695151766611, 5545.72271386429, 5576.187738984765, 5146.948530514647, 5311.920321195185, 5323.547498462674, 5329.32126380189, 5336.946630533645, 2938.5160493950843, 2988.3713376210017, 3004.662924998355, 3024.3346463777934, 3029.8939537116094, 5689.971550142222, 5736.483716465538, 5775.393583673737, 5795.275590551181, 5838.32859221195, 5303.867403314871, 5559.694216818114, 5575.330960284792, 5642.915356269659, 5649.971750141223, 5676.801311954062, 5721.312212897205, 5724.79963201286, 5728.911506813692, 5844.1525978732, 5527.944720552743, 5533.8457079465925, 5576.721163941867, 5832.854178645398, 6279.277883043508, 6253.1245625613365, 6266.216722909637, 6281.685915704288, 6282.555012347277, 6292.433680968735, 6341.968290158704, 6518.121717578034, 6535.477161827138, 6554.180727409074, 6581.177352830896, 4410.29435290352, 4437.534058923767, 4472.172648060119, 4485.730856148642, 4485.977570112129, 6110.908336375047, 6176.81469555914, 6327.3988971047675, 6434.613923164625, 6440.774572889926, 6110.7250173741395, 6135.202423684892, 6160.168377269011, 6166.929826314611, 6178.548041210402, 6052.606580572248, 6106.572539922163, 6115.480184184395, 6144.631322120687, 6151.0, 5882.382349853375, 6071.362506936708, 6098.26199533131, 6107.297660769068, 6207.782727604512, 6280.120783090462, 6293.96853015732, 6297.716602752978, 6308.306086330592, 6323.083152942706, 6018.939810601838, 6055.0, 6090.695465226632, 6096.512279017579, 6155.076338739063], "value": 4541.6038041553875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.0099682374795, 840.3445312656129, 853.5305581929941, 934.8364036293649, 966.737261741622, 17138.914305428472, 18539.907300463496, 18593.0, 18694.15876285567, 18741.437756867297, 15434.69130617387, 16666.333346666117, 16701.49895503137, 16752.078635675032, 16817.32730690774, 882.4396508217264, 903.7424334064793, 904.3036861616552, 906.6056265524518, 909.8134882349136, 895.5880295064278, 900.6577500549782, 901.1709227510706, 901.3510272603714, 902.6705252582825, 932.6036434515304, 939.1641439119189, 940.7412961435591, 941.0589410589411, 942.8302905477011, 932.1144912333243, 935.0088905759916, 936.0779632062413, 939.6523286384047, 941.4069136444031, 687.0552989639247, 688.0779755128102, 689.4484412470003, 692.1071817355605, 692.9930700692979, 15569.766453503207, 15635.452759153375, 15932.12373319467, 16008.919955400148, 16013.839861601351, 14292.928535357256, 14825.18461484618, 14948.775768363483, 14973.1016139032, 15203.923980380137, 11503.827442588368, 12180.208286461351, 12665.620031399072, 12743.490260389573, 12752.936235318857, 4051.5948405159543, 4129.215449064668, 4151.304787944039, 4187.91624167518, 4245.066085461193, 49592.0, 58175.0, 73134.26865731328, 84443.57778211132, 85677.57161214216, 11461.656150315504, 11632.709182270342, 11800.822987655192, 11985.700357491132, 12011.399430028463, 24239.0, 24457.021719131037, 24469.0, 24611.384715382257, 24622.507549849262, 9571.473568953774, 9597.90402095984, 9694.61221551144, 9718.951405242928, 9869.161121304625, 4948.505149485095, 5054.16606259963, 5129.12804823181, 5165.845024649267, 5353.036453438341, 3878.0, 3993.9001524961527, 4006.7395619284653, 4022.235775202702, 4053.5541090480615, 725.408791834653, 728.366321300472, 731.8792399254063, 748.8090536913053, 749.4341771962243, 825.2984962781587, 825.405707890318, 843.5908584336592, 850.4897061763016, 852.411835833273, 10662.786744265071, 10929.688437387564, 11163.0, 11570.479328430241, 11972.745936189069, 775.8293175501381, 800.651716503323, 800.9479383840148, 831.6881169561415, 852.3735054734765, 5297.576193904479, 5553.383644686379, 5622.128570071645, 5706.942930570641, 5849.181114643953, 108579.0, 132769.3361533186, 135041.32479337737, 135519.0, 137954.0, 32470.512942305886, 32769.0, 83373.0, 95547.0, 95579.52210239043, 76433.0, 77734.61132694414, 83874.0, 94302.0, 95453.0, 10859.565617375216, 10886.346819190874, 11075.169362297698, 11304.83042754343, 11323.490442930253, 51984.14087225239, 52706.73646631742, 53319.46680533145, 55149.44850551443, 55383.446165537825, 70927.64536177285, 78467.21532784599, 78842.0, 78908.0, 81262.0, 13458.596242112751, 13782.93108534451, 14310.785338220143, 14566.0, 14653.780193297322, 15491.0, 15866.603334916257, 16367.67264654724, 16814.831851681327, 17058.0, 15500.0, 15510.767338489706, 16230.0, 16667.66664666724, 16908.23912923946, 14521.636959076108, 14834.703305933604, 15024.24878756036, 15860.52418427449, 16398.344066237216, 14984.550463486114, 16417.507474775775, 16452.670946581242, 16539.0, 16586.419475318788, 11795.469203885674, 11904.76190476203, 12167.0, 12193.573224937085, 12341.3829308536, 11318.717032074264, 12836.55072072473, 12903.161294515827, 12921.483140674267, 13409.128406653535], "value": 8257.765797075044, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 104.0, 109.0, 111.0, 112.0, 109.0, 110.0, 109.0, 111.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 140.0, 171.0, 120.0, 148.0, 143.0, 121.0, 172.0, 116.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 165.0, 162.0, 162.0, 160.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 184.0, 76.0, 75.0, 75.0, 76.0, 180.0, 76.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 156.0, 84.0, 86.0, 83.0, 144.0, 85.0, 83.0, 136.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 49.0, 50.0, 51.0, 53.0, 59.0, 51.0, 51.0, 50.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 72.0, 72.0, 71.0, 78.0, 73.0, 76.0, 80.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 128.0, 122.0, 119.0, 118.0, 121.0, 118.0, 121.0, 152.0, 119.0], "value": 123.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 154.0, 151.0, 152.0, 154.0, 154.0, 150.0, 153.0, 151.0, 153.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 61.0, 62.0, 63.0, 60.0, 61.0, 61.0, 60.0], "value": 61.7, "unit": "score"}]}]} 03:16:32 INFO - Return code: 0 03:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:32 ERROR - # TBPL SUCCESS # 03:16:32 INFO - Running post-action listener: _resource_record_post_action 03:16:32 INFO - [mozharness: 2016-08-17 10:16:32.321736Z] Finished run-tests step (success) 03:16:32 INFO - Running post-run listener: _resource_record_post_run 03:16:32 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 326852608; Read time: 16; Write time: 273468 03:16:32 INFO - TinderboxPrint: CPU usage
13.3% 03:16:32 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 03:16:32 INFO - TinderboxPrint: I/O write bytes / time
326,852,608 / 273,468 03:16:32 INFO - TinderboxPrint: CPU idle
8,227.4 (86.7%) 03:16:32 INFO - TinderboxPrint: CPU user
1,202.8 (12.7%) 03:16:32 INFO - TinderboxPrint: Swap in / out
0 / 0 03:16:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78610432; Read time: 0; Write time: 62260 03:16:32 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247111680; Read time: 16; Write time: 210980 03:16:32 INFO - Running post-run listener: _upload_blobber_files 03:16:32 INFO - Blob upload gear active. 03:16:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:32 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 03:16:32 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'] 03:16:32 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 03:16:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:34 INFO - (blobuploader) - INFO - Done attempting. 03:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:34 INFO - (blobuploader) - INFO - Done attempting. 03:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:38 INFO - (blobuploader) - INFO - Done attempting. 03:16:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:38 INFO - Return code: 0 03:16:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f397e15d334705eb5a1b12dc5a272d1c20ff9d78d75c446c1f1f9a93c34c69e34dbb22529815738b194c0f5625697fc316231b3e56cf5d3cc4b05937b4060198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bdf43b8e543707b85657d0124520922b119498b8d0c4e1ee4b39bc4e84c023fd19b81791a52c9d0edd69ee9eeddb3b6f1c1feca1f21aa5891533bd005848f79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e61d05732a77e32b91ad2560ead17dbe24ec15e1565ce7e2dc363c0fd8f10d7a3e8c627714b36e79aa7dcb34f1e9a627711716e8869bde3acaf0df32c3ef7b36"} 03:16:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:38 INFO - Contents: 03:16:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f397e15d334705eb5a1b12dc5a272d1c20ff9d78d75c446c1f1f9a93c34c69e34dbb22529815738b194c0f5625697fc316231b3e56cf5d3cc4b05937b4060198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bdf43b8e543707b85657d0124520922b119498b8d0c4e1ee4b39bc4e84c023fd19b81791a52c9d0edd69ee9eeddb3b6f1c1feca1f21aa5891533bd005848f79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e61d05732a77e32b91ad2560ead17dbe24ec15e1565ce7e2dc363c0fd8f10d7a3e8c627714b36e79aa7dcb34f1e9a627711716e8869bde3acaf0df32c3ef7b36"} 03:16:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:38 INFO - Copying logs to upload dir... 03:16:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.312152 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-08-17 03:16:38.153734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:16:38.158825) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 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/f397e15d334705eb5a1b12dc5a272d1c20ff9d78d75c446c1f1f9a93c34c69e34dbb22529815738b194c0f5625697fc316231b3e56cf5d3cc4b05937b4060198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bdf43b8e543707b85657d0124520922b119498b8d0c4e1ee4b39bc4e84c023fd19b81791a52c9d0edd69ee9eeddb3b6f1c1feca1f21aa5891533bd005848f79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e61d05732a77e32b91ad2560ead17dbe24ec15e1565ce7e2dc363c0fd8f10d7a3e8c627714b36e79aa7dcb34f1e9a627711716e8869bde3acaf0df32c3ef7b36"} build_url:https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/M4ysyOjBS2ay7bRiZoTWbg/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/f397e15d334705eb5a1b12dc5a272d1c20ff9d78d75c446c1f1f9a93c34c69e34dbb22529815738b194c0f5625697fc316231b3e56cf5d3cc4b05937b4060198", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bdf43b8e543707b85657d0124520922b119498b8d0c4e1ee4b39bc4e84c023fd19b81791a52c9d0edd69ee9eeddb3b6f1c1feca1f21aa5891533bd005848f79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e61d05732a77e32b91ad2560ead17dbe24ec15e1565ce7e2dc363c0fd8f10d7a3e8c627714b36e79aa7dcb34f1e9a627711716e8869bde3acaf0df32c3ef7b36"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 03:16:38.185911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:16:38.186357) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1471423624.623743-650420913 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 03:16:38.267516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:16:38.267846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 03:16:38.268244) ========= ========= Total master_lag: 0.18 =========